Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-MacOSX/3974/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseG1GC

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([5D4ED86C95420D67:D51AE7B63BBE609F]: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:159)
        at 
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:144)
        at 
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:139)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForRecoveriesToFinish(AbstractFullDistribZkTestBase.java:861)
        at 
org.apache.solr.cloud.FullSolrCloudDistribCmdsTest.testIndexingBatchPerRequestWithHttpSolrClient(FullSolrCloudDistribCmdsTest.java:620)
        at 
org.apache.solr.cloud.FullSolrCloudDistribCmdsTest.test(FullSolrCloudDistribCmdsTest.java:152)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:985)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
        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:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 11658 lines...]
   [junit4] Suite: org.apache.solr.cloud.FullSolrCloudDistribCmdsTest
   [junit4]   2> Creating dataDir: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/init-core-data-001
   [junit4]   2> 1070710 INFO  
(SUITE-FullSolrCloudDistribCmdsTest-seed#[5D4ED86C95420D67]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using TrieFields
   [junit4]   2> 1070711 INFO  
(SUITE-FullSolrCloudDistribCmdsTest-seed#[5D4ED86C95420D67]-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> 1070712 INFO  
(SUITE-FullSolrCloudDistribCmdsTest-seed#[5D4ED86C95420D67]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: 
/dadr/yn
   [junit4]   2> 1070715 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1070716 INFO  (Thread-1865) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1070716 INFO  (Thread-1865) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1070718 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:61296
   [junit4]   2> 1070720 ERROR (Thread-1865) [    ] 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> 1070757 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
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> 1070761 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
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> 1070764 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
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> 1070768 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
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> 1070771 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
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> 1070773 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
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> 1070777 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
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> 1070780 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
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> 1070783 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
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> 1070786 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
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> 1070789 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
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> 1071393 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/control-001/cores/collection1
   [junit4]   2> 1071395 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1071397 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@7220e203{/dadr/yn,null,AVAILABLE}
   [junit4]   2> 1071399 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@1b9e805c{HTTP/1.1,[http/1.1]}{127.0.0.1:61300}
   [junit4]   2> 1071399 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.e.j.s.Server Started @1076785ms
   [junit4]   2> 1071399 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/tempDir-001/control/data,
 hostContext=/dadr/yn, hostPort=61300, 
coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/control-001/cores}
   [junit4]   2> 1071400 ERROR 
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1071400 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 1071400 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1071400 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1071400 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-04-28T18:13:37.419Z
   [junit4]   2> 1071405 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 1071405 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/control-001/solr.xml
   [junit4]   2> 1071437 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@33c9b983, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1071445 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61296/solr
   [junit4]   2> 1071498 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61300_dadr%2Fyn    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1071500 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61300_dadr%2Fyn    ] o.a.s.c.OverseerElectionContext I am going to 
be the leader 127.0.0.1:61300_dadr%2Fyn
   [junit4]   2> 1071508 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61300_dadr%2Fyn    ] o.a.s.c.Overseer Overseer 
(id=97871673212076036-127.0.0.1:61300_dadr%2Fyn-n_0000000000) starting
   [junit4]   2> 1071523 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61300_dadr%2Fyn    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:61300_dadr%2Fyn
   [junit4]   2> 1071528 INFO  
(zkCallback-2227-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn) 
[n:127.0.0.1:61300_dadr%2Fyn    ] o.a.s.c.c.ZkStateReader Updated live nodes 
from ZooKeeper... (0) -> (1)
   [junit4]   2> 1071712 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61300_dadr%2Fyn    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@33c9b983
   [junit4]   2> 1071717 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61300_dadr%2Fyn    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@33c9b983
   [junit4]   2> 1071718 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61300_dadr%2Fyn    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@33c9b983
   [junit4]   2> 1071721 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61300_dadr%2Fyn    ] o.a.s.c.CorePropertiesLocator Found 1 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/control-001/cores
   [junit4]   2> 1071721 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61300_dadr%2Fyn    ] o.a.s.c.CorePropertiesLocator Cores are: 
[collection1]
   [junit4]   2> 1071723 INFO  
(coreLoadExecutor-4495-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn) 
[n:127.0.0.1:61300_dadr%2Fyn c:control_collection   x:collection1] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1071727 INFO  
(OverseerStateUpdate-97871673212076036-127.0.0.1:61300_dadr%2Fyn-n_0000000000) 
[n:127.0.0.1:61300_dadr%2Fyn    ] o.a.s.c.o.ReplicaMutator Assigning new node 
to shard shard=shard1
   [junit4]   2> 1072774 WARN  
(coreLoadExecutor-4495-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn) 
[n:127.0.0.1:61300_dadr%2Fyn c:control_collection   x:collection1] 
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use 
<mergePolicyFactory> instead.
   [junit4]   2> 1072775 INFO  
(coreLoadExecutor-4495-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn) 
[n:127.0.0.1:61300_dadr%2Fyn c:control_collection   x:collection1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1072787 INFO  
(coreLoadExecutor-4495-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn) 
[n:127.0.0.1:61300_dadr%2Fyn c:control_collection   x:collection1] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1072871 WARN  
(coreLoadExecutor-4495-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn) 
[n:127.0.0.1:61300_dadr%2Fyn c:control_collection   x:collection1] 
o.a.s.s.IndexSchema [collection1] default search field in schema is text. 
WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 1072872 INFO  
(coreLoadExecutor-4495-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn) 
[n:127.0.0.1:61300_dadr%2Fyn c:control_collection   x:collection1] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1072901 INFO  
(coreLoadExecutor-4495-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn) 
[n:127.0.0.1:61300_dadr%2Fyn c:control_collection   x:collection1] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
collection control_collection, trusted=true
   [junit4]   2> 1072901 INFO  
(coreLoadExecutor-4495-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn) 
[n:127.0.0.1:61300_dadr%2Fyn c:control_collection   x:collection1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.control_collection.shard1.core_node1' (registry 
'solr.core.control_collection.shard1.core_node1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@33c9b983
   [junit4]   2> 1072901 INFO  
(coreLoadExecutor-4495-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn) 
[n:127.0.0.1:61300_dadr%2Fyn c:control_collection   x:collection1] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 1072902 INFO  
(coreLoadExecutor-4495-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn) 
[n:127.0.0.1:61300_dadr%2Fyn c:control_collection   x:collection1] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/control-001/cores/collection1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/control-001/cores/collection1/data/]
   [junit4]   2> 1072903 INFO  
(coreLoadExecutor-4495-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn) 
[n:127.0.0.1:61300_dadr%2Fyn c:control_collection   x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=25, maxMergeAtOnceExplicit=29, maxMergedSegmentMB=18.1982421875, 
floorSegmentMB=1.126953125, forceMergeDeletesPctAllowed=7.516054669867628, 
segmentsPerTier=50.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 1072915 WARN  
(coreLoadExecutor-4495-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn) 
[n:127.0.0.1:61300_dadr%2Fyn c:control_collection   x:collection1] 
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> 1072992 INFO  
(coreLoadExecutor-4495-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn) 
[n:127.0.0.1:61300_dadr%2Fyn c:control_collection   x:collection1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1072992 INFO  
(coreLoadExecutor-4495-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn) 
[n:127.0.0.1:61300_dadr%2Fyn c:control_collection   x:collection1] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1072993 INFO  
(coreLoadExecutor-4495-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn) 
[n:127.0.0.1:61300_dadr%2Fyn c:control_collection   x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1072993 INFO  
(coreLoadExecutor-4495-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn) 
[n:127.0.0.1:61300_dadr%2Fyn c:control_collection   x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1072994 INFO  
(coreLoadExecutor-4495-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn) 
[n:127.0.0.1:61300_dadr%2Fyn c:control_collection   x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=13, maxMergeAtOnceExplicit=45, maxMergedSegmentMB=2.123046875, 
floorSegmentMB=1.91796875, forceMergeDeletesPctAllowed=5.053568877664145, 
segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 1072994 INFO  
(coreLoadExecutor-4495-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn) 
[n:127.0.0.1:61300_dadr%2Fyn c:control_collection   x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@52247475[collection1] main]
   [junit4]   2> 1072996 INFO  
(coreLoadExecutor-4495-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn) 
[n:127.0.0.1:61300_dadr%2Fyn c:control_collection   x:collection1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1072997 INFO  
(coreLoadExecutor-4495-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn) 
[n:127.0.0.1:61300_dadr%2Fyn c:control_collection   x:collection1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1072997 INFO  
(coreLoadExecutor-4495-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn) 
[n:127.0.0.1:61300_dadr%2Fyn c:control_collection   x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1072998 INFO  
(coreLoadExecutor-4495-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn) 
[n:127.0.0.1:61300_dadr%2Fyn c:control_collection   x:collection1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1565946773783969792
   [junit4]   2> 1072999 INFO  
(searcherExecutor-4496-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn 
x:collection1 c:control_collection) [n:127.0.0.1:61300_dadr%2Fyn 
c:control_collection   x:collection1] o.a.s.c.SolrCore [collection1] Registered 
new searcher Searcher@52247475[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1073010 INFO  
(coreZkRegister-4488-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn 
x:collection1 c:control_collection) [n:127.0.0.1:61300_dadr%2Fyn 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1073010 INFO  
(coreZkRegister-4488-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn 
x:collection1 c:control_collection) [n:127.0.0.1:61300_dadr%2Fyn 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1073011 INFO  
(coreZkRegister-4488-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn 
x:collection1 c:control_collection) [n:127.0.0.1:61300_dadr%2Fyn 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
Sync replicas to http://127.0.0.1:61300/dadr/yn/collection1/
   [junit4]   2> 1073011 INFO  
(coreZkRegister-4488-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn 
x:collection1 c:control_collection) [n:127.0.0.1:61300_dadr%2Fyn 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 1073011 INFO  
(coreZkRegister-4488-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn 
x:collection1 c:control_collection) [n:127.0.0.1:61300_dadr%2Fyn 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
http://127.0.0.1:61300/dadr/yn/collection1/ has no replicas
   [junit4]   2> 1073011 INFO  
(coreZkRegister-4488-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn 
x:collection1 c:control_collection) [n:127.0.0.1:61300_dadr%2Fyn 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 1073018 INFO  
(coreZkRegister-4488-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn 
x:collection1 c:control_collection) [n:127.0.0.1:61300_dadr%2Fyn 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:61300/dadr/yn/collection1/ shard1
   [junit4]   2> 1073170 INFO  
(coreZkRegister-4488-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn 
x:collection1 c:control_collection) [n:127.0.0.1:61300_dadr%2Fyn 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
I am the leader, no recovery necessary
   [junit4]   2> 1073273 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1073276 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:61296/solr ready
   [junit4]   2> 1073276 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection 
loss:false
   [junit4]   2> 1074012 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/shard-1-001/cores/collection1
   [junit4]   2> 1074013 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/shard-1-001
   [junit4]   2> 1074013 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1074015 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@2b5c9842{/dadr/yn,null,AVAILABLE}
   [junit4]   2> 1074016 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@e50519c{HTTP/1.1,[http/1.1]}{127.0.0.1:61307}
   [junit4]   2> 1074016 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.e.j.s.Server Started @1079402ms
   [junit4]   2> 1074016 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/tempDir-001/jetty1,
 solrconfig=solrconfig.xml, hostContext=/dadr/yn, hostPort=61307, 
coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/shard-1-001/cores}
   [junit4]   2> 1074017 ERROR 
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1074018 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 1074018 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1074018 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1074018 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-04-28T18:13:40.037Z
   [junit4]   2> 1074023 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 1074023 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/shard-1-001/solr.xml
   [junit4]   2> 1074049 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@33c9b983, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1074053 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61296/solr
   [junit4]   2> 1074071 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61307_dadr%2Fyn    ] o.a.s.c.c.ZkStateReader Updated live nodes 
from ZooKeeper... (0) -> (1)
   [junit4]   2> 1074076 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61307_dadr%2Fyn    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1074080 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61307_dadr%2Fyn    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:61307_dadr%2Fyn
   [junit4]   2> 1074083 INFO  
(zkCallback-2227-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn) 
[n:127.0.0.1:61300_dadr%2Fyn    ] o.a.s.c.c.ZkStateReader Updated live nodes 
from ZooKeeper... (1) -> (2)
   [junit4]   2> 1074083 INFO  (zkCallback-2231-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1074084 INFO  
(zkCallback-2236-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn) 
[n:127.0.0.1:61307_dadr%2Fyn    ] o.a.s.c.c.ZkStateReader Updated live nodes 
from ZooKeeper... (1) -> (2)
   [junit4]   2> 1074192 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61307_dadr%2Fyn    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@33c9b983
   [junit4]   2> 1074197 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61307_dadr%2Fyn    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@33c9b983
   [junit4]   2> 1074198 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61307_dadr%2Fyn    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@33c9b983
   [junit4]   2> 1074201 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61307_dadr%2Fyn    ] o.a.s.c.CorePropertiesLocator Found 1 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/shard-1-001/cores
   [junit4]   2> 1074201 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61307_dadr%2Fyn    ] o.a.s.c.CorePropertiesLocator Cores are: 
[collection1]
   [junit4]   2> 1074202 INFO  
(coreLoadExecutor-4506-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn) 
[n:127.0.0.1:61307_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1074204 INFO  
(OverseerStateUpdate-97871673212076036-127.0.0.1:61300_dadr%2Fyn-n_0000000000) 
[n:127.0.0.1:61300_dadr%2Fyn    ] o.a.s.c.o.ReplicaMutator Assigning new node 
to shard shard=shard2
   [junit4]   2> 1075230 WARN  
(coreLoadExecutor-4506-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn) 
[n:127.0.0.1:61307_dadr%2Fyn c:collection1   x:collection1] o.a.s.c.Config 
Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> 
instead.
   [junit4]   2> 1075231 INFO  
(coreLoadExecutor-4506-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn) 
[n:127.0.0.1:61307_dadr%2Fyn c:collection1   x:collection1] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1075241 INFO  
(coreLoadExecutor-4506-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn) 
[n:127.0.0.1:61307_dadr%2Fyn c:collection1   x:collection1] o.a.s.s.IndexSchema 
[collection1] Schema name=test
   [junit4]   2> 1075316 WARN  
(coreLoadExecutor-4506-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn) 
[n:127.0.0.1:61307_dadr%2Fyn c:collection1   x:collection1] o.a.s.s.IndexSchema 
[collection1] default search field in schema is text. WARNING: Deprecated, 
please use 'df' on request instead.
   [junit4]   2> 1075317 INFO  
(coreLoadExecutor-4506-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn) 
[n:127.0.0.1:61307_dadr%2Fyn c:collection1   x:collection1] o.a.s.s.IndexSchema 
Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1075347 INFO  
(coreLoadExecutor-4506-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn) 
[n:127.0.0.1:61307_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
collection collection1, trusted=true
   [junit4]   2> 1075347 INFO  
(coreLoadExecutor-4506-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn) 
[n:127.0.0.1:61307_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1.shard2.core_node1' (registry 
'solr.core.collection1.shard2.core_node1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@33c9b983
   [junit4]   2> 1075347 INFO  
(coreLoadExecutor-4506-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn) 
[n:127.0.0.1:61307_dadr%2Fyn c:collection1   x:collection1] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1075347 INFO  
(coreLoadExecutor-4506-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn) 
[n:127.0.0.1:61307_dadr%2Fyn c:collection1   x:collection1] o.a.s.c.SolrCore 
[[collection1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/shard-1-001/cores/collection1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/shard-1-001/cores/collection1/data/]
   [junit4]   2> 1075349 INFO  
(coreLoadExecutor-4506-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn) 
[n:127.0.0.1:61307_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=25, maxMergeAtOnceExplicit=29, maxMergedSegmentMB=18.1982421875, 
floorSegmentMB=1.126953125, forceMergeDeletesPctAllowed=7.516054669867628, 
segmentsPerTier=50.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 1075353 WARN  
(coreLoadExecutor-4506-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn) 
[n:127.0.0.1:61307_dadr%2Fyn c:collection1   x:collection1] 
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> 1075428 INFO  
(coreLoadExecutor-4506-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn) 
[n:127.0.0.1:61307_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1075428 INFO  
(coreLoadExecutor-4506-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn) 
[n:127.0.0.1:61307_dadr%2Fyn c:collection1   x:collection1] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1075429 INFO  
(coreLoadExecutor-4506-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn) 
[n:127.0.0.1:61307_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1075429 INFO  
(coreLoadExecutor-4506-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn) 
[n:127.0.0.1:61307_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1075430 INFO  
(coreLoadExecutor-4506-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn) 
[n:127.0.0.1:61307_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=13, maxMergeAtOnceExplicit=45, maxMergedSegmentMB=2.123046875, 
floorSegmentMB=1.91796875, forceMergeDeletesPctAllowed=5.053568877664145, 
segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 1075430 INFO  
(coreLoadExecutor-4506-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn) 
[n:127.0.0.1:61307_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@793dfe3b[collection1] main]
   [junit4]   2> 1075432 INFO  
(coreLoadExecutor-4506-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn) 
[n:127.0.0.1:61307_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1075433 INFO  
(coreLoadExecutor-4506-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn) 
[n:127.0.0.1:61307_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1075433 INFO  
(coreLoadExecutor-4506-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn) 
[n:127.0.0.1:61307_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1075435 INFO  
(coreLoadExecutor-4506-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn) 
[n:127.0.0.1:61307_dadr%2Fyn c:collection1   x:collection1] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1565946776339349504
   [junit4]   2> 1075436 INFO  
(searcherExecutor-4507-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61307_dadr%2Fyn c:collection1   
x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@793dfe3b[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1075445 INFO  
(coreZkRegister-4501-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61307_dadr%2Fyn c:collection1 
s:shard2 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough 
replicas found to continue.
   [junit4]   2> 1075445 INFO  
(coreZkRegister-4501-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61307_dadr%2Fyn c:collection1 
s:shard2 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I may 
be the new leader - try and sync
   [junit4]   2> 1075446 INFO  
(coreZkRegister-4501-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61307_dadr%2Fyn c:collection1 
s:shard2 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:61307/dadr/yn/collection1/
   [junit4]   2> 1075446 INFO  
(coreZkRegister-4501-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61307_dadr%2Fyn c:collection1 
s:shard2 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now 
sync replicas to me
   [junit4]   2> 1075446 INFO  
(coreZkRegister-4501-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61307_dadr%2Fyn c:collection1 
s:shard2 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
http://127.0.0.1:61307/dadr/yn/collection1/ has no replicas
   [junit4]   2> 1075446 INFO  
(coreZkRegister-4501-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61307_dadr%2Fyn c:collection1 
s:shard2 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Found 
all replicas participating in election, clear LIR
   [junit4]   2> 1075453 INFO  
(coreZkRegister-4501-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61307_dadr%2Fyn c:collection1 
s:shard2 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I am 
the new leader: http://127.0.0.1:61307/dadr/yn/collection1/ shard2
   [junit4]   2> 1075560 INFO  
(coreZkRegister-4501-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61307_dadr%2Fyn c:collection1 
s:shard2 r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no 
recovery necessary
   [junit4]   2> 1076507 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/shard-2-001/cores/collection1
   [junit4]   2> 1076508 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/shard-2-001
   [junit4]   2> 1076509 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1076511 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@6faaf203{/dadr/yn,null,AVAILABLE}
   [junit4]   2> 1076511 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@1184227d{HTTP/1.1,[http/1.1]}{127.0.0.1:61316}
   [junit4]   2> 1076511 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.e.j.s.Server Started @1081897ms
   [junit4]   2> 1076511 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/tempDir-001/jetty2,
 solrconfig=solrconfig.xml, hostContext=/dadr/yn, hostPort=61316, 
coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/shard-2-001/cores}
   [junit4]   2> 1076511 ERROR 
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1076512 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 1076512 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1076512 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1076512 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-04-28T18:13:42.531Z
   [junit4]   2> 1076516 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 1076516 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/shard-2-001/solr.xml
   [junit4]   2> 1076583 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@33c9b983, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1076588 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61296/solr
   [junit4]   2> 1076606 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61316_dadr%2Fyn    ] o.a.s.c.c.ZkStateReader Updated live nodes 
from ZooKeeper... (0) -> (2)
   [junit4]   2> 1076611 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61316_dadr%2Fyn    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1076615 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61316_dadr%2Fyn    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:61316_dadr%2Fyn
   [junit4]   2> 1076618 INFO  (zkCallback-2231-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1076618 INFO  
(zkCallback-2227-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn) 
[n:127.0.0.1:61300_dadr%2Fyn    ] o.a.s.c.c.ZkStateReader Updated live nodes 
from ZooKeeper... (2) -> (3)
   [junit4]   2> 1076618 INFO  
(zkCallback-2236-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn) 
[n:127.0.0.1:61307_dadr%2Fyn    ] o.a.s.c.c.ZkStateReader Updated live nodes 
from ZooKeeper... (2) -> (3)
   [junit4]   2> 1076620 INFO  
(zkCallback-2242-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn) 
[n:127.0.0.1:61316_dadr%2Fyn    ] o.a.s.c.c.ZkStateReader Updated live nodes 
from ZooKeeper... (2) -> (3)
   [junit4]   2> 1077220 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61316_dadr%2Fyn    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@33c9b983
   [junit4]   2> 1077226 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61316_dadr%2Fyn    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@33c9b983
   [junit4]   2> 1077226 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61316_dadr%2Fyn    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@33c9b983
   [junit4]   2> 1077230 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61316_dadr%2Fyn    ] o.a.s.c.CorePropertiesLocator Found 1 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/shard-2-001/cores
   [junit4]   2> 1077230 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61316_dadr%2Fyn    ] o.a.s.c.CorePropertiesLocator Cores are: 
[collection1]
   [junit4]   2> 1077231 INFO  
(coreLoadExecutor-4517-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn) 
[n:127.0.0.1:61316_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1077234 INFO  
(OverseerStateUpdate-97871673212076036-127.0.0.1:61300_dadr%2Fyn-n_0000000000) 
[n:127.0.0.1:61300_dadr%2Fyn    ] o.a.s.c.o.ReplicaMutator Assigning new node 
to shard shard=shard3
   [junit4]   2> 1078265 WARN  
(coreLoadExecutor-4517-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn) 
[n:127.0.0.1:61316_dadr%2Fyn c:collection1   x:collection1] o.a.s.c.Config 
Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> 
instead.
   [junit4]   2> 1078266 INFO  
(coreLoadExecutor-4517-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn) 
[n:127.0.0.1:61316_dadr%2Fyn c:collection1   x:collection1] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1078277 INFO  
(coreLoadExecutor-4517-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn) 
[n:127.0.0.1:61316_dadr%2Fyn c:collection1   x:collection1] o.a.s.s.IndexSchema 
[collection1] Schema name=test
   [junit4]   2> 1078373 WARN  
(coreLoadExecutor-4517-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn) 
[n:127.0.0.1:61316_dadr%2Fyn c:collection1   x:collection1] o.a.s.s.IndexSchema 
[collection1] default search field in schema is text. WARNING: Deprecated, 
please use 'df' on request instead.
   [junit4]   2> 1078375 INFO  
(coreLoadExecutor-4517-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn) 
[n:127.0.0.1:61316_dadr%2Fyn c:collection1   x:collection1] o.a.s.s.IndexSchema 
Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1078409 INFO  
(coreLoadExecutor-4517-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn) 
[n:127.0.0.1:61316_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
collection collection1, trusted=true
   [junit4]   2> 1078410 INFO  
(coreLoadExecutor-4517-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn) 
[n:127.0.0.1:61316_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1.shard3.core_node2' (registry 
'solr.core.collection1.shard3.core_node2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@33c9b983
   [junit4]   2> 1078410 INFO  
(coreLoadExecutor-4517-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn) 
[n:127.0.0.1:61316_dadr%2Fyn c:collection1   x:collection1] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1078410 INFO  
(coreLoadExecutor-4517-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn) 
[n:127.0.0.1:61316_dadr%2Fyn c:collection1   x:collection1] o.a.s.c.SolrCore 
[[collection1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/shard-2-001/cores/collection1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/shard-2-001/cores/collection1/data/]
   [junit4]   2> 1078413 INFO  
(coreLoadExecutor-4517-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn) 
[n:127.0.0.1:61316_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=25, maxMergeAtOnceExplicit=29, maxMergedSegmentMB=18.1982421875, 
floorSegmentMB=1.126953125, forceMergeDeletesPctAllowed=7.516054669867628, 
segmentsPerTier=50.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 1078418 WARN  
(coreLoadExecutor-4517-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn) 
[n:127.0.0.1:61316_dadr%2Fyn c:collection1   x:collection1] 
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> 1078513 INFO  
(coreLoadExecutor-4517-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn) 
[n:127.0.0.1:61316_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1078513 INFO  
(coreLoadExecutor-4517-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn) 
[n:127.0.0.1:61316_dadr%2Fyn c:collection1   x:collection1] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1078515 INFO  
(coreLoadExecutor-4517-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn) 
[n:127.0.0.1:61316_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1078515 INFO  
(coreLoadExecutor-4517-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn) 
[n:127.0.0.1:61316_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1078516 INFO  
(coreLoadExecutor-4517-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn) 
[n:127.0.0.1:61316_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=13, maxMergeAtOnceExplicit=45, maxMergedSegmentMB=2.123046875, 
floorSegmentMB=1.91796875, forceMergeDeletesPctAllowed=5.053568877664145, 
segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 1078516 INFO  
(coreLoadExecutor-4517-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn) 
[n:127.0.0.1:61316_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@2381e52[collection1] main]
   [junit4]   2> 1078523 INFO  
(coreLoadExecutor-4517-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn) 
[n:127.0.0.1:61316_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1078525 INFO  
(coreLoadExecutor-4517-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn) 
[n:127.0.0.1:61316_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1078525 INFO  
(coreLoadExecutor-4517-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn) 
[n:127.0.0.1:61316_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1078526 INFO  
(coreLoadExecutor-4517-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn) 
[n:127.0.0.1:61316_dadr%2Fyn c:collection1   x:collection1] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1565946779580497920
   [junit4]   2> 1078529 INFO  
(searcherExecutor-4518-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61316_dadr%2Fyn c:collection1   
x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@2381e52[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1078536 INFO  
(coreZkRegister-4512-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61316_dadr%2Fyn c:collection1 
s:shard3 r:core_node2 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough 
replicas found to continue.
   [junit4]   2> 1078537 INFO  
(coreZkRegister-4512-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61316_dadr%2Fyn c:collection1 
s:shard3 r:core_node2 x:collection1] o.a.s.c.ShardLeaderElectionContext I may 
be the new leader - try and sync
   [junit4]   2> 1078537 INFO  
(coreZkRegister-4512-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61316_dadr%2Fyn c:collection1 
s:shard3 r:core_node2 x:collection1] o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:61316/dadr/yn/collection1/
   [junit4]   2> 1078537 INFO  
(coreZkRegister-4512-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61316_dadr%2Fyn c:collection1 
s:shard3 r:core_node2 x:collection1] o.a.s.c.SyncStrategy Sync Success - now 
sync replicas to me
   [junit4]   2> 1078537 INFO  
(coreZkRegister-4512-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61316_dadr%2Fyn c:collection1 
s:shard3 r:core_node2 x:collection1] o.a.s.c.SyncStrategy 
http://127.0.0.1:61316/dadr/yn/collection1/ has no replicas
   [junit4]   2> 1078537 INFO  
(coreZkRegister-4512-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61316_dadr%2Fyn c:collection1 
s:shard3 r:core_node2 x:collection1] o.a.s.c.ShardLeaderElectionContext Found 
all replicas participating in election, clear LIR
   [junit4]   2> 1078544 INFO  
(coreZkRegister-4512-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61316_dadr%2Fyn c:collection1 
s:shard3 r:core_node2 x:collection1] o.a.s.c.ShardLeaderElectionContext I am 
the new leader: http://127.0.0.1:61316/dadr/yn/collection1/ shard3
   [junit4]   2> 1078712 INFO  
(coreZkRegister-4512-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61316_dadr%2Fyn c:collection1 
s:shard3 r:core_node2 x:collection1] o.a.s.c.ZkController I am the leader, no 
recovery necessary
   [junit4]   2> 1079255 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/shard-3-001/cores/collection1
   [junit4]   2> 1079257 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 3 in directory 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/shard-3-001
   [junit4]   2> 1079257 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1079259 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@2b0bb606{/dadr/yn,null,AVAILABLE}
   [junit4]   2> 1079259 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@c867883{HTTP/1.1,[http/1.1]}{127.0.0.1:61326}
   [junit4]   2> 1079260 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.e.j.s.Server Started @1084645ms
   [junit4]   2> 1079260 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/tempDir-001/jetty3,
 solrconfig=solrconfig.xml, hostContext=/dadr/yn, hostPort=61326, 
coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/shard-3-001/cores}
   [junit4]   2> 1079260 ERROR 
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1079260 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 1079260 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1079260 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1079260 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-04-28T18:13:45.279Z
   [junit4]   2> 1079265 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 1079265 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/shard-3-001/solr.xml
   [junit4]   2> 1079293 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@33c9b983, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1079297 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61296/solr
   [junit4]   2> 1079316 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61326_dadr%2Fyn    ] o.a.s.c.c.ZkStateReader Updated live nodes 
from ZooKeeper... (0) -> (3)
   [junit4]   2> 1079321 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61326_dadr%2Fyn    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1079325 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61326_dadr%2Fyn    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:61326_dadr%2Fyn
   [junit4]   2> 1079329 INFO  
(zkCallback-2236-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn) 
[n:127.0.0.1:61307_dadr%2Fyn    ] o.a.s.c.c.ZkStateReader Updated live nodes 
from ZooKeeper... (3) -> (4)
   [junit4]   2> 1079329 INFO  (zkCallback-2231-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1079330 INFO  
(zkCallback-2248-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn) 
[n:127.0.0.1:61326_dadr%2Fyn    ] o.a.s.c.c.ZkStateReader Updated live nodes 
from ZooKeeper... (3) -> (4)
   [junit4]   2> 1079330 INFO  
(zkCallback-2227-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn) 
[n:127.0.0.1:61300_dadr%2Fyn    ] o.a.s.c.c.ZkStateReader Updated live nodes 
from ZooKeeper... (3) -> (4)
   [junit4]   2> 1079331 INFO  
(zkCallback-2242-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn) 
[n:127.0.0.1:61316_dadr%2Fyn    ] o.a.s.c.c.ZkStateReader Updated live nodes 
from ZooKeeper... (3) -> (4)
   [junit4]   2> 1079463 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61326_dadr%2Fyn    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@33c9b983
   [junit4]   2> 1079470 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61326_dadr%2Fyn    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@33c9b983
   [junit4]   2> 1079470 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61326_dadr%2Fyn    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@33c9b983
   [junit4]   2> 1079473 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61326_dadr%2Fyn    ] o.a.s.c.CorePropertiesLocator Found 1 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/shard-3-001/cores
   [junit4]   2> 1079473 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61326_dadr%2Fyn    ] o.a.s.c.CorePropertiesLocator Cores are: 
[collection1]
   [junit4]   2> 1079474 INFO  
(coreLoadExecutor-4528-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn) 
[n:127.0.0.1:61326_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1079476 INFO  
(OverseerStateUpdate-97871673212076036-127.0.0.1:61300_dadr%2Fyn-n_0000000000) 
[n:127.0.0.1:61300_dadr%2Fyn    ] o.a.s.c.o.ReplicaMutator Assigning new node 
to shard shard=shard1
   [junit4]   2> 1080504 WARN  
(coreLoadExecutor-4528-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn) 
[n:127.0.0.1:61326_dadr%2Fyn c:collection1   x:collection1] o.a.s.c.Config 
Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> 
instead.
   [junit4]   2> 1080504 INFO  
(coreLoadExecutor-4528-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn) 
[n:127.0.0.1:61326_dadr%2Fyn c:collection1   x:collection1] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1080520 INFO  
(coreLoadExecutor-4528-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn) 
[n:127.0.0.1:61326_dadr%2Fyn c:collection1   x:collection1] o.a.s.s.IndexSchema 
[collection1] Schema name=test
   [junit4]   2> 1080624 WARN  
(coreLoadExecutor-4528-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn) 
[n:127.0.0.1:61326_dadr%2Fyn c:collection1   x:collection1] o.a.s.s.IndexSchema 
[collection1] default search field in schema is text. WARNING: Deprecated, 
please use 'df' on request instead.
   [junit4]   2> 1080626 INFO  
(coreLoadExecutor-4528-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn) 
[n:127.0.0.1:61326_dadr%2Fyn c:collection1   x:collection1] o.a.s.s.IndexSchema 
Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1080658 INFO  
(coreLoadExecutor-4528-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn) 
[n:127.0.0.1:61326_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
collection collection1, trusted=true
   [junit4]   2> 1080659 INFO  
(coreLoadExecutor-4528-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn) 
[n:127.0.0.1:61326_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1.shard1.core_node3' (registry 
'solr.core.collection1.shard1.core_node3') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@33c9b983
   [junit4]   2> 1080659 INFO  
(coreLoadExecutor-4528-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn) 
[n:127.0.0.1:61326_dadr%2Fyn c:collection1   x:collection1] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1080659 INFO  
(coreLoadExecutor-4528-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn) 
[n:127.0.0.1:61326_dadr%2Fyn c:collection1   x:collection1] o.a.s.c.SolrCore 
[[collection1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/shard-3-001/cores/collection1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/shard-3-001/cores/collection1/data/]
   [junit4]   2> 1080663 INFO  
(coreLoadExecutor-4528-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn) 
[n:127.0.0.1:61326_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=25, maxMergeAtOnceExplicit=29, maxMergedSegmentMB=18.1982421875, 
floorSegmentMB=1.126953125, forceMergeDeletesPctAllowed=7.516054669867628, 
segmentsPerTier=50.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 1080672 WARN  
(coreLoadExecutor-4528-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn) 
[n:127.0.0.1:61326_dadr%2Fyn c:collection1   x:collection1] 
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> 1080768 INFO  
(coreLoadExecutor-4528-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn) 
[n:127.0.0.1:61326_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1080768 INFO  
(coreLoadExecutor-4528-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn) 
[n:127.0.0.1:61326_dadr%2Fyn c:collection1   x:collection1] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1080769 INFO  
(coreLoadExecutor-4528-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn) 
[n:127.0.0.1:61326_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1080769 INFO  
(coreLoadExecutor-4528-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn) 
[n:127.0.0.1:61326_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1080770 INFO  
(coreLoadExecutor-4528-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn) 
[n:127.0.0.1:61326_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=13, maxMergeAtOnceExplicit=45, maxMergedSegmentMB=2.123046875, 
floorSegmentMB=1.91796875, forceMergeDeletesPctAllowed=5.053568877664145, 
segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 1080770 INFO  
(coreLoadExecutor-4528-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn) 
[n:127.0.0.1:61326_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@5e77aa40[collection1] main]
   [junit4]   2> 1080773 INFO  
(coreLoadExecutor-4528-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn) 
[n:127.0.0.1:61326_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1080774 INFO  
(coreLoadExecutor-4528-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn) 
[n:127.0.0.1:61326_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1080775 INFO  
(coreLoadExecutor-4528-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn) 
[n:127.0.0.1:61326_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1080775 INFO  
(coreLoadExecutor-4528-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn) 
[n:127.0.0.1:61326_dadr%2Fyn c:collection1   x:collection1] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1565946781938745344
   [junit4]   2> 1080776 INFO  
(searcherExecutor-4529-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61326_dadr%2Fyn c:collection1   
x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@5e77aa40[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1080786 INFO  
(coreZkRegister-4523-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61326_dadr%2Fyn c:collection1 
s:shard1 r:core_node3 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough 
replicas found to continue.
   [junit4]   2> 1080786 INFO  
(coreZkRegister-4523-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61326_dadr%2Fyn c:collection1 
s:shard1 r:core_node3 x:collection1] o.a.s.c.ShardLeaderElectionContext I may 
be the new leader - try and sync
   [junit4]   2> 1080786 INFO  
(coreZkRegister-4523-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61326_dadr%2Fyn c:collection1 
s:shard1 r:core_node3 x:collection1] o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:61326/dadr/yn/collection1/
   [junit4]   2> 1080786 INFO  
(coreZkRegister-4523-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61326_dadr%2Fyn c:collection1 
s:shard1 r:core_node3 x:collection1] o.a.s.c.SyncStrategy Sync Success - now 
sync replicas to me
   [junit4]   2> 1080786 INFO  
(coreZkRegister-4523-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61326_dadr%2Fyn c:collection1 
s:shard1 r:core_node3 x:collection1] o.a.s.c.SyncStrategy 
http://127.0.0.1:61326/dadr/yn/collection1/ has no replicas
   [junit4]   2> 1080786 INFO  
(coreZkRegister-4523-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61326_dadr%2Fyn c:collection1 
s:shard1 r:core_node3 x:collection1] o.a.s.c.ShardLeaderElectionContext Found 
all replicas participating in election, clear LIR
   [junit4]   2> 1080798 INFO  
(coreZkRegister-4523-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61326_dadr%2Fyn c:collection1 
s:shard1 r:core_node3 x:collection1] o.a.s.c.ShardLeaderElectionContext I am 
the new leader: http://127.0.0.1:61326/dadr/yn/collection1/ shard1
   [junit4]   2> 1080959 INFO  
(coreZkRegister-4523-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61326_dadr%2Fyn c:collection1 
s:shard1 r:core_node3 x:collection1] o.a.s.c.ZkController I am the leader, no 
recovery necessary
   [junit4]   2> 1081543 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/shard-4-001/cores/collection1
   [junit4]   2> 1081547 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 4 in directory 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/shard-4-001
   [junit4]   2> 1081549 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1081552 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@2b7b945b{/dadr/yn,null,AVAILABLE}
   [junit4]   2> 1081553 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@16656c0f{HTTP/1.1,[http/1.1]}{127.0.0.1:61330}
   [junit4]   2> 1081553 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.e.j.s.Server Started @1086939ms
   [junit4]   2> 1081553 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/tempDir-001/jetty4,
 solrconfig=solrconfig.xml, hostContext=/dadr/yn, hostPort=61330, 
coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/shard-4-001/cores}
   [junit4]   2> 1081554 ERROR 
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1081554 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 1081554 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1081554 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1081554 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-04-28T18:13:47.573Z
   [junit4]   2> 1081560 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 1081560 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/shard-4-001/solr.xml
   [junit4]   2> 1081566 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@33c9b983, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1081573 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61296/solr
   [junit4]   2> 1081595 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61330_dadr%2Fyn    ] o.a.s.c.c.ZkStateReader Updated live nodes 
from ZooKeeper... (0) -> (4)
   [junit4]   2> 1081602 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61330_dadr%2Fyn    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1081606 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61330_dadr%2Fyn    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:61330_dadr%2Fyn
   [junit4]   2> 1081611 INFO  (zkCallback-2231-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1081611 INFO  
(zkCallback-2248-thread-1-processing-n:127.0.0.1:61326_dadr%2Fyn) 
[n:127.0.0.1:61326_dadr%2Fyn    ] o.a.s.c.c.ZkStateReader Updated live nodes 
from ZooKeeper... (4) -> (5)
   [junit4]   2> 1081611 INFO  
(zkCallback-2236-thread-1-processing-n:127.0.0.1:61307_dadr%2Fyn) 
[n:127.0.0.1:61307_dadr%2Fyn    ] o.a.s.c.c.ZkStateReader Updated live nodes 
from ZooKeeper... (4) -> (5)
   [junit4]   2> 1081611 INFO  
(zkCallback-2242-thread-1-processing-n:127.0.0.1:61316_dadr%2Fyn) 
[n:127.0.0.1:61316_dadr%2Fyn    ] o.a.s.c.c.ZkStateReader Updated live nodes 
from ZooKeeper... (4) -> (5)
   [junit4]   2> 1081611 INFO  
(zkCallback-2227-thread-1-processing-n:127.0.0.1:61300_dadr%2Fyn) 
[n:127.0.0.1:61300_dadr%2Fyn    ] o.a.s.c.c.ZkStateReader Updated live nodes 
from ZooKeeper... (4) -> (5)
   [junit4]   2> 1081612 INFO  
(zkCallback-2254-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn) 
[n:127.0.0.1:61330_dadr%2Fyn    ] o.a.s.c.c.ZkStateReader Updated live nodes 
from ZooKeeper... (4) -> (5)
   [junit4]   2> 1081780 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61330_dadr%2Fyn    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@33c9b983
   [junit4]   2> 1081789 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61330_dadr%2Fyn    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@33c9b983
   [junit4]   2> 1081790 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61330_dadr%2Fyn    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@33c9b983
   [junit4]   2> 1081794 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61330_dadr%2Fyn    ] o.a.s.c.CorePropertiesLocator Found 1 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/shard-4-001/cores
   [junit4]   2> 1081794 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[5D4ED86C95420D67]) 
[n:127.0.0.1:61330_dadr%2Fyn    ] o.a.s.c.CorePropertiesLocator Cores are: 
[collection1]
   [junit4]   2> 1081794 INFO  
(coreLoadExecutor-4539-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn) 
[n:127.0.0.1:61330_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1081796 INFO  
(OverseerStateUpdate-97871673212076036-127.0.0.1:61300_dadr%2Fyn-n_0000000000) 
[n:127.0.0.1:61300_dadr%2Fyn    ] o.a.s.c.o.ReplicaMutator Assigning new node 
to shard shard=shard2
   [junit4]   2> 1082822 WARN  
(coreLoadExecutor-4539-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn) 
[n:127.0.0.1:61330_dadr%2Fyn c:collection1   x:collection1] o.a.s.c.Config 
Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> 
instead.
   [junit4]   2> 1082822 INFO  
(coreLoadExecutor-4539-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn) 
[n:127.0.0.1:61330_dadr%2Fyn c:collection1   x:collection1] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1082871 INFO  
(coreLoadExecutor-4539-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn) 
[n:127.0.0.1:61330_dadr%2Fyn c:collection1   x:collection1] o.a.s.s.IndexSchema 
[collection1] Schema name=test
   [junit4]   2> 1082963 WARN  
(coreLoadExecutor-4539-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn) 
[n:127.0.0.1:61330_dadr%2Fyn c:collection1   x:collection1] o.a.s.s.IndexSchema 
[collection1] default search field in schema is text. WARNING: Deprecated, 
please use 'df' on request instead.
   [junit4]   2> 1082965 INFO  
(coreLoadExecutor-4539-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn) 
[n:127.0.0.1:61330_dadr%2Fyn c:collection1   x:collection1] o.a.s.s.IndexSchema 
Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 1082993 INFO  
(coreLoadExecutor-4539-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn) 
[n:127.0.0.1:61330_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
collection collection1, trusted=true
   [junit4]   2> 1082993 INFO  
(coreLoadExecutor-4539-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn) 
[n:127.0.0.1:61330_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1.shard2.core_node4' (registry 
'solr.core.collection1.shard2.core_node4') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@33c9b983
   [junit4]   2> 1082994 INFO  
(coreLoadExecutor-4539-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn) 
[n:127.0.0.1:61330_dadr%2Fyn c:collection1   x:collection1] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1082994 INFO  
(coreLoadExecutor-4539-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn) 
[n:127.0.0.1:61330_dadr%2Fyn c:collection1   x:collection1] o.a.s.c.SolrCore 
[[collection1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/shard-4-001/cores/collection1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001/shard-4-001/cores/collection1/data/]
   [junit4]   2> 1082997 INFO  
(coreLoadExecutor-4539-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn) 
[n:127.0.0.1:61330_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=25, maxMergeAtOnceExplicit=29, maxMergedSegmentMB=18.1982421875, 
floorSegmentMB=1.126953125, forceMergeDeletesPctAllowed=7.516054669867628, 
segmentsPerTier=50.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 1083000 WARN  
(coreLoadExecutor-4539-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn) 
[n:127.0.0.1:61330_dadr%2Fyn c:collection1   x:collection1] 
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> 1083073 INFO  
(coreLoadExecutor-4539-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn) 
[n:127.0.0.1:61330_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1083074 INFO  
(coreLoadExecutor-4539-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn) 
[n:127.0.0.1:61330_dadr%2Fyn c:collection1   x:collection1] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1083075 INFO  
(coreLoadExecutor-4539-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn) 
[n:127.0.0.1:61330_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1083075 INFO  
(coreLoadExecutor-4539-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn) 
[n:127.0.0.1:61330_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1083076 INFO  
(coreLoadExecutor-4539-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn) 
[n:127.0.0.1:61330_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=13, maxMergeAtOnceExplicit=45, maxMergedSegmentMB=2.123046875, 
floorSegmentMB=1.91796875, forceMergeDeletesPctAllowed=5.053568877664145, 
segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 1083076 INFO  
(coreLoadExecutor-4539-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn) 
[n:127.0.0.1:61330_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@e4817bb[collection1] main]
   [junit4]   2> 1083079 INFO  
(coreLoadExecutor-4539-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn) 
[n:127.0.0.1:61330_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1083079 INFO  
(coreLoadExecutor-4539-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn) 
[n:127.0.0.1:61330_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1083080 INFO  
(coreLoadExecutor-4539-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn) 
[n:127.0.0.1:61330_dadr%2Fyn c:collection1   x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1083080 INFO  
(coreLoadExecutor-4539-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn) 
[n:127.0.0.1:61330_dadr%2Fyn c:collection1   x:collection1] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1565946784355713024
   [junit4]   2> 1083082 INFO  
(searcherExecutor-4540-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61330_dadr%2Fyn c:collection1   
x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@e4817bb[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1083086 INFO  
(coreZkRegister-4534-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn 
x:collection1 c:collection1) [n:127.0.0.1:61330_dadr%2Fyn c:collection1 
s:shard2 r:core_node4 x:collection1] o.a.s.c.ZkController Core needs to 
recover:collection1
   [junit4]   2> 1083086 INFO  
(updateExecutor-2251-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn 
x:collection1 s:shard2 c:collection1 r:core_node4) [n:127.0.0.1:61330_dadr%2Fyn 
c:collection1 s:shard2 r:core_node4 x:collection1] o.a.s.u.DefaultSolrCoreState 
Running recovery
   [junit4]   2> 1083087 INFO  
(recoveryExecutor-2252-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn 
x:collection1 s:shard2 c:collection1 r:core_node4) [n:127.0.0.1:61330_dadr%2Fyn 
c:collection1 s:shard2 r:core_node4 x:collection1] o.a.s.c.RecoveryStrategy 
Starting recovery process. recoveringAfterStartup=true
   [junit4]   2> 1083087 INFO  
(recoveryExecutor-2252-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn 
x:collection1 s:shard2 c:collection1 r:core_node4) [n:127.0.0.1:61330_dadr%2Fyn 
c:collection1 s:shard2 r:core_node4 x:collection1] o.a.s.c.RecoveryStrategy 
###### startupVersions=[[]]
   [junit4]   2> 1083087 INFO  
(recoveryExecutor-2252-thread-1-processing-n:127.0.0.1:61330_dadr%2Fyn 
x:collection1 s:shard2 c:collection1 r:core_node4) [n:127.0.0.1:61330_dadr%2Fyn 
c:collection1 s:sh

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

esToFinish(AbstractFullDistribZkTestBase.java:861)
   [junit4]    >        at 
org.apache.solr.cloud.FullSolrCloudDistribCmdsTest.testIndexingBatchPerRequestWithHttpSolrClient(FullSolrCloudDistribCmdsTest.java:620)
   [junit4]    >        at 
org.apache.solr.cloud.FullSolrCloudDistribCmdsTest.test(FullSolrCloudDistribCmdsTest.java:152)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:985)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 1141533 INFO  
(SUITE-FullSolrCloudDistribCmdsTest-seed#[5D4ED86C95420D67]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.FullSolrCloudDistribCmdsTest_5D4ED86C95420D67-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{6grand2_s=BlockTreeOrds(blocksize=128), 
7grand5_s=BlockTreeOrds(blocksize=128), 4grand0_s=BlockTreeOrds(blocksize=128), 
7grand1_s=BlockTreeOrds(blocksize=128), 9grand7_s=BlockTreeOrds(blocksize=128), 
8grand0_s=BlockTreeOrds(blocksize=128), 9grand3_s=BlockTreeOrds(blocksize=128), 
6parent_f2_s=PostingsFormat(name=Asserting), 
8grand4_s=BlockTreeOrds(blocksize=128), 
0parent_f2_s=PostingsFormat(name=LuceneFixedGap), 
3grand1_s=BlockTreeOrds(blocksize=128), 
4parent_f1_s=BlockTreeOrds(blocksize=128), 
11grand10_s=PostingsFormat(name=Asserting), 
5child3_s=BlockTreeOrds(blocksize=128), 
9parent_f2_s=BlockTreeOrds(blocksize=128), a_t=PostingsFormat(name=MockRandom), 
6child2_s=BlockTreeOrds(blocksize=128), id=PostingsFormat(name=LuceneFixedGap), 
5grand3_s=BlockTreeOrds(blocksize=128), 
1parent_f1_s=PostingsFormat(name=Asserting), 
6child1_s=PostingsFormat(name=Asserting), 
_root_=PostingsFormat(name=MockRandom), 
5child2_s=PostingsFormat(name=LuceneFixedGap), 
3child0_s=PostingsFormat(name=Asserting), 
4child3_s=PostingsFormat(name=Asserting), 
1grand0_s=PostingsFormat(name=Asserting), 
11grand2_s=PostingsFormat(name=MockRandom), 
11grand6_s=PostingsFormat(name=MockRandom), 
10grand7_s=PostingsFormat(name=MockRandom), 
7parent_f1_s=PostingsFormat(name=LuceneFixedGap), 
2child1_s=PostingsFormat(name=LuceneFixedGap), 
3parent_f2_s=PostingsFormat(name=MockRandom), 
10grand3_s=PostingsFormat(name=MockRandom), 
6grand3_s=PostingsFormat(name=Asserting), 
5grand2_s=PostingsFormat(name=Asserting), 
10grand9_s=BlockTreeOrds(blocksize=128), 
11parent_f2_s=PostingsFormat(name=Asserting), 
4grand1_s=PostingsFormat(name=Asserting), 
7grand4_s=PostingsFormat(name=Asserting), 
3grand0_s=PostingsFormat(name=Asserting), 
9grand6_s=PostingsFormat(name=LuceneFixedGap), 
8grand1_s=PostingsFormat(name=Asserting), 
9grand2_s=PostingsFormat(name=LuceneFixedGap), 
8grand5_s=PostingsFormat(name=Asserting), 
9parent_f1_s=PostingsFormat(name=Asserting), 
1parent_f2_s=BlockTreeOrds(blocksize=128), 
6child3_s=PostingsFormat(name=LuceneFixedGap), 
7grand0_s=PostingsFormat(name=Asserting), 
text_t=PostingsFormat(name=MockRandom), type_s=PostingsFormat(name=MockRandom), 
5child1_s=PostingsFormat(name=MockRandom), 
10parent_f1_s=PostingsFormat(name=Asserting), 
11grand1_s=PostingsFormat(name=Asserting), 
10grand0_s=PostingsFormat(name=Asserting), 
4child0_s=BlockTreeOrds(blocksize=128), 
11grand5_s=PostingsFormat(name=Asserting), 
10grand8_s=PostingsFormat(name=Asserting), 
10grand4_s=PostingsFormat(name=Asserting), 
5grand1_s=PostingsFormat(name=MockRandom), 
6grand4_s=PostingsFormat(name=MockRandom), 
11parent_f1_s=BlockTreeOrds(blocksize=128), 
4grand2_s=PostingsFormat(name=MockRandom), 
7grand3_s=PostingsFormat(name=MockRandom), 
11grand9_s=PostingsFormat(name=Asserting), 
8grand2_s=PostingsFormat(name=MockRandom), 
9grand5_s=PostingsFormat(name=MockRandom), 
8grand6_s=PostingsFormat(name=MockRandom), 
9grand1_s=PostingsFormat(name=MockRandom), 
6child4_s=PostingsFormat(name=MockRandom), 
5parent_f1_s=PostingsFormat(name=Asserting), 
6grand0_s=PostingsFormat(name=MockRandom), 
10parent_f2_s=PostingsFormat(name=MockRandom), 
5child0_s=PostingsFormat(name=Asserting), 
8parent_f1_s=BlockTreeOrds(blocksize=128), 
2parent_f2_s=PostingsFormat(name=Asserting), 
11grand0_s=BlockTreeOrds(blocksize=128), 
4child1_s=PostingsFormat(name=LuceneFixedGap), 
2grand1_s=PostingsFormat(name=Asserting), 
11grand4_s=BlockTreeOrds(blocksize=128), 
3child2_s=PostingsFormat(name=LuceneFixedGap), 
10grand5_s=BlockTreeOrds(blocksize=128), 
1child0_s=PostingsFormat(name=LuceneFixedGap), 
10grand1_s=BlockTreeOrds(blocksize=128), 
7grand6_s=PostingsFormat(name=LuceneFixedGap), 
5grand0_s=PostingsFormat(name=LuceneFixedGap), 
6grand5_s=PostingsFormat(name=LuceneFixedGap), 
7grand2_s=PostingsFormat(name=LuceneFixedGap), 
4grand3_s=PostingsFormat(name=LuceneFixedGap), 
9grand8_s=PostingsFormat(name=Asserting), 
11grand8_s=BlockTreeOrds(blocksize=128), 
8grand3_s=PostingsFormat(name=LuceneFixedGap), 
6parent_f1_s=PostingsFormat(name=MockRandom), 
9grand4_s=PostingsFormat(name=Asserting), 
8grand7_s=PostingsFormat(name=LuceneFixedGap), 
0parent_f1_s=BlockTreeOrds(blocksize=128), 
3grand2_s=PostingsFormat(name=LuceneFixedGap), 
9grand0_s=PostingsFormat(name=Asserting), 
4parent_f2_s=PostingsFormat(name=LuceneFixedGap), 
5child4_s=PostingsFormat(name=Asserting), 
6child5_s=PostingsFormat(name=Asserting), 
5grand4_s=PostingsFormat(name=LuceneFixedGap), 
6grand1_s=PostingsFormat(name=LuceneFixedGap), 
5parent_f2_s=BlockTreeOrds(blocksize=128), 
6child0_s=PostingsFormat(name=MockRandom), 
8parent_f2_s=PostingsFormat(name=LuceneFixedGap), 
2parent_f1_s=PostingsFormat(name=MockRandom), 
4child2_s=PostingsFormat(name=MockRandom), 
rnd_b=PostingsFormat(name=LuceneFixedGap), 
11grand3_s=PostingsFormat(name=LuceneFixedGap), 
2grand0_s=PostingsFormat(name=MockRandom), 
11grand7_s=PostingsFormat(name=LuceneFixedGap), 
3child1_s=BlockTreeOrds(blocksize=128), 
10grand6_s=PostingsFormat(name=LuceneFixedGap), 
7parent_f2_s=PostingsFormat(name=MockRandom), 
10grand2_s=PostingsFormat(name=LuceneFixedGap), 
2child0_s=PostingsFormat(name=MockRandom), 
3parent_f1_s=PostingsFormat(name=LuceneFixedGap)}, 
docValues:{_version_=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=958, 
maxMBSortInHeap=6.954963539078444, sim=RandomSimilarity(queryNorm=true): {}, 
locale=th-TH, timezone=America/Puerto_Rico
   [junit4]   2> NOTE: Mac OS X 10.11.6 x86_64/Oracle Corporation 1.8.0_121 
(64-bit)/cpus=3,threads=1,free=279051512,total=530579456
   [junit4]   2> NOTE: All tests run in this JVM: [TestMissingGroups, 
OverseerStatusTest, SimpleCollectionCreateDeleteTest, ScriptEngineTest, 
ForceLeaderTest, TestDynamicLoading, TestRecoveryHdfs, TestRecovery, 
TestQueryTypes, TestRangeQuery, SolrJmxReporterTest, LukeRequestHandlerTest, 
TestTrieFacet, TestAnalyzedSuggestions, DistributedIntervalFacetingTest, 
TestHdfsCloudBackupRestore, TestGeoJSONResponseWriter, 
ClassificationUpdateProcessorTest, BJQParserTest, TestDocumentBuilder, 
ConfigSetsAPITest, UUIDUpdateProcessorFallbackTest, CleanupOldIndexTest, 
TestDistributedGrouping, HdfsBasicDistributedZkTest, 
TestTolerantUpdateProcessorCloud, UpdateLogTest, TestCodecSupport, 
TestFieldTypeCollectionResource, UpdateRequestProcessorFactoryTest, 
TestRealTimeGet, DistributedExpandComponentTest, TestJoin, HdfsNNFailoverTest, 
NotRequiredUniqueKeyTest, HLLUtilTest, DeleteInactiveReplicaTest, TestPathTrie, 
TestIndexingPerformance, TestAnalyzeInfixSuggestions, TestSearchPerf, 
HighlighterMaxOffsetTest, CloudMLTQParserTest, FullHLLTest, 
SignatureUpdateProcessorFactoryTest, TestMacros, TestExactStatsCache, 
TestCoreDiscovery, DocExpirationUpdateProcessorFactoryTest, BitVectorTest, 
DeleteNodeTest, DistributedQueryComponentOptimizationTest, 
TestSubQueryTransformerDistrib, TestLRUCache, DefaultValueUpdateProcessorTest, 
CdcrVersionReplicationTest, SharedFSAutoReplicaFailoverTest, 
LeaderElectionIntegrationTest, SpellPossibilityIteratorTest, CoreSorterTest, 
PreAnalyzedFieldTest, LeaderInitiatedRecoveryOnShardRestartTest, 
SpatialHeatmapFacetsTest, BlockJoinFacetRandomTest, AutoCommitTest, 
SmileWriterTest, TestSlowCompositeReaderWrapper, 
TestPHPSerializedResponseWriter, TestAddFieldRealTimeGet, 
SpellCheckComponentTest, WordBreakSolrSpellCheckerTest, SolrMetricReporterTest, 
AnalysisErrorHandlingTest, TestHighFrequencyDictionaryFactory, 
HdfsTlogReplayBufferedWhileIndexingTest, FieldMutatingUpdateProcessorTest, 
TestFilteredDocIdSet, ChangedSchemaMergeTest, TestIntervalFaceting, 
TestExpandComponent, AnalyticsQueryTest, StatsReloadRaceTest, 
TestUseDocValuesAsStored2, MetricsHandlerTest, CurrencyFieldOpenExchangeTest, 
TestFiltering, TestConfig, MissingSegmentRecoveryTest, StatsComponentTest, 
TestFastWriter, SolrCmdDistributorTest, TestClusterStateMutator, 
TestHdfsBackupRestoreCore, ParsingFieldUpdateProcessorsTest, 
TestDynamicFieldCollectionResource, TestManagedSchemaAPI, DeleteShardTest, 
TestRebalanceLeaders, TestRTimerTree, ExternalFileFieldSortTest, 
SolrIndexMetricsTest, GraphQueryTest, SuggestComponentTest, 
DistribJoinFromCollectionTest, PKIAuthenticationIntegrationTest, 
DebugComponentTest, TestSolrQueryParser, URLClassifyProcessorTest, 
DistributedFacetPivotWhiteBoxTest, TestLeaderElectionZkExpiry, 
TestSolrDeletionPolicy2, TestFoldingMultitermQuery, 
TestLMJelinekMercerSimilarityFactory, HttpSolrCallGetCoreTest, 
BadCopyFieldTest, SolrInfoBeanTest, TestCloudInspectUtil, BadIndexSchemaTest, 
SolrIndexSplitterTest, ShowFileRequestHandlerTest, TestFieldCacheSortRandom, 
TestNRTOpen, TestNonDefinedSimilarityFactory, TermVectorComponentTest, 
DocValuesMissingTest, TestOrdValues, TestSQLHandler, BasicAuthIntegrationTest, 
TestFieldCacheReopen, ReturnFieldsTest, TestSystemCollAutoCreate, 
OverseerModifyCollectionTest, BlobRepositoryCloudTest, CircularListTest, 
WrapperMergePolicyFactoryTest, FullSolrCloudDistribCmdsTest]
   [junit4] Completed [230/705 (1!)] on J1 in 70.84s, 1 test, 1 failure <<< 
FAILURES!

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

Reply via email to