Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-master/1327/

4 tests failed.
FAILED:  org.apache.solr.handler.extraction.TestExtractionDateUtil.testParseDate

Error Message:
Incorrect parsed timestamp: 1226583351000 != 1226579751000 (Thu Nov 13 04:35:51 
AKST 2008)

Stack Trace:
java.lang.AssertionError: Incorrect parsed timestamp: 1226583351000 != 
1226579751000 (Thu Nov 13 04:35:51 AKST 2008)
        at 
__randomizedtesting.SeedInfo.seed([1405E46F66B64616:5E1C9C5A1D1F31A3]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at 
org.apache.solr.handler.extraction.TestExtractionDateUtil.assertParsedDate(TestExtractionDateUtil.java:59)
        at 
org.apache.solr.handler.extraction.TestExtractionDateUtil.testParseDate(TestExtractionDateUtil.java:54)
        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.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 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)


FAILED:  org.apache.solr.cloud.CollectionsAPISolrJTest.testCreateAndDeleteShard

Error Message:
Error from server at https://127.0.0.1:34108/solr: deleteshard the collection 
time out:180s

Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at https://127.0.0.1:34108/solr: deleteshard the collection time 
out:180s
        at 
__randomizedtesting.SeedInfo.seed([B693392A06F62FF5:73CD8D368003E508]:0)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:595)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:231)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:220)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:459)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:389)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1135)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:876)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:807)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:178)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:195)
        at 
org.apache.solr.cloud.CollectionsAPISolrJTest.testCreateAndDeleteShard(CollectionsAPISolrJTest.java:143)
        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 
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:748)


FAILED:  
org.apache.solr.handler.TestReplicationHandler.doTestReplicateAfterCoreReload

Error Message:
expected:<[{indexVersion=1497614187568,generation=2,filelist=[_6wd.fdt, 
_6wd.fdx, _6wd.fnm, _6wd.nvd, _6wd.nvm, _6wd.si, _6wd_Lucene50_0.doc, 
_6wd_Lucene50_0.tim, _6wd_Lucene50_0.tip, _dpe.fdt, _dpe.fdx, _dpe.fnm, 
_dpe.nvd, _dpe.nvm, _dpe.si, _dpe_Lucene50_0.doc, _dpe_Lucene50_0.tim, 
_dpe_Lucene50_0.tip, _jvx.fdt, _jvx.fdx, _jvx.fnm, _jvx.nvd, _jvx.nvm, _jvx.si, 
_jvx_Lucene50_0.doc, _jvx_Lucene50_0.tim, _jvx_Lucene50_0.tip, _jwr.cfe, 
_jwr.cfs, _jwr.si, _jws.fdt, _jws.fdx, _jws.fnm, _jws.nvd, _jws.nvm, _jws.si, 
_jws_Lucene50_0.doc, _jws_Lucene50_0.tim, _jws_Lucene50_0.tip, _jwt.cfe, 
_jwt.cfs, _jwt.si, _jwu.cfe, _jwu.cfs, _jwu.si, _jwv.cfe, _jwv.cfs, _jwv.si, 
_jww.cfe, _jww.cfs, _jww.si, _jwx.cfe, _jwx.cfs, _jwx.si, _jwy.cfe, _jwy.cfs, 
_jwy.si, _jwz.cfe, _jwz.cfs, _jwz.si, _jx0.cfe, _jx0.cfs, _jx0.si, _jx1.cfe, 
_jx1.cfs, _jx1.si, _jx2.cfe, _jx2.cfs, _jx2.si, _jx3.cfe, _jx3.cfs, _jx3.si, 
_jx4.cfe, _jx4.cfs, _jx4.si, _jx5.cfe, _jx5.cfs, _jx5.si, _jx6.cfe, _jx6.cfs, 
_jx6.si, _jx7.cfe, _jx7.cfs, _jx7.si, _jx8.cfe, _jx8.cfs, _jx8.si, _jx9.cfe, 
_jx9.cfs, _jx9.si, _jxa.cfe, _jxa.cfs, _jxa.si, _jxb.cfe, _jxb.cfs, _jxb.si, 
_jxc.cfe, _jxc.cfs, _jxc.si, _jxd.cfe, _jxd.cfs, _jxd.si, _jxe.cfe, _jxe.cfs, 
_jxe.si, _jxf.cfe, _jxf.cfs, _jxf.si, _jxg.cfe, _jxg.cfs, _jxg.si, _jxh.cfe, 
_jxh.cfs, _jxh.si, _jxi.cfe, _jxi.cfs, _jxi.si, _jxj.cfe, _jxj.cfs, _jxj.si, 
_jxk.cfe, _jxk.cfs, _jxk.si, _jxm.cfe, _jxm.cfs, _jxm.si, _jxn.cfe, _jxn.cfs, 
_jxn.si, _jxo.cfe, _jxo.cfs, _jxo.si, _jxp.cfe, _jxp.cfs, _jxp.si, _jxq.cfe, 
_jxq.cfs, _jxq.si, _jxr.cfe, _jxr.cfs, _jxr.si, _jxs.cfe, _jxs.cfs, _jxs.si, 
_jxt.cfe, _jxt.cfs, _jxt.si, _jxu.cfe, _jxu.cfs, _jxu.si, _jxv.cfe, _jxv.cfs, 
_jxv.si, _jxw.cfe, _jxw.cfs, _jxw.si, _jxx.cfe, _jxx.cfs, _jxx.si, _jxy.cfe, 
_jxy.cfs, _jxy.si, _jxz.cfe, _jxz.cfs, _jxz.si, _jy0.cfe, _jy0.cfs, _jy0.si, 
_jy1.cfe, _jy1.cfs, _jy1.si, _jy2.cfe, _jy2.cfs, _jy2.si, _jy3.cfe, _jy3.cfs, 
_jy3.si, _jy4.cfe, _jy4.cfs, _jy4.si, _jy5.cfe, _jy5.cfs, _jy5.si, _jy6.cfe, 
_jy6.cfs, _jy6.si, _jy7.cfe, _jy7.cfs, _jy7.si, _jy8.cfe, _jy8.cfs, _jy8.si, 
_jy9.cfe, _jy9.cfs, _jy9.si, _jya.cfe, _jya.cfs, _jya.si, _jyb.cfe, _jyb.cfs, 
_jyb.si, _jyc.cfe, _jyc.cfs, _jyc.si, segments_2]}]> but 
was:<[{indexVersion=1497614187568,generation=2,filelist=[_6wd.fdt, _6wd.fdx, 
_6wd.fnm, _6wd.nvd, _6wd.nvm, _6wd.si, _6wd_Lucene50_0.doc, 
_6wd_Lucene50_0.tim, _6wd_Lucene50_0.tip, _dpe.fdt, _dpe.fdx, _dpe.fnm, 
_dpe.nvd, _dpe.nvm, _dpe.si, _dpe_Lucene50_0.doc, _dpe_Lucene50_0.tim, 
_dpe_Lucene50_0.tip, _jvx.fdt, _jvx.fdx, _jvx.fnm, _jvx.nvd, _jvx.nvm, _jvx.si, 
_jvx_Lucene50_0.doc, _jvx_Lucene50_0.tim, _jvx_Lucene50_0.tip, _jwr.cfe, 
_jwr.cfs, _jwr.si, _jws.fdt, _jws.fdx, _jws.fnm, _jws.nvd, _jws.nvm, _jws.si, 
_jws_Lucene50_0.doc, _jws_Lucene50_0.tim, _jws_Lucene50_0.tip, _jwt.cfe, 
_jwt.cfs, _jwt.si, _jwu.cfe, _jwu.cfs, _jwu.si, _jwv.cfe, _jwv.cfs, _jwv.si, 
_jww.cfe, _jww.cfs, _jww.si, _jwx.cfe, _jwx.cfs, _jwx.si, _jwy.cfe, _jwy.cfs, 
_jwy.si, _jwz.cfe, _jwz.cfs, _jwz.si, _jx0.cfe, _jx0.cfs, _jx0.si, _jx1.cfe, 
_jx1.cfs, _jx1.si, _jx2.cfe, _jx2.cfs, _jx2.si, _jx3.cfe, _jx3.cfs, _jx3.si, 
_jx4.cfe, _jx4.cfs, _jx4.si, _jx5.cfe, _jx5.cfs, _jx5.si, _jx6.cfe, _jx6.cfs, 
_jx6.si, _jx7.cfe, _jx7.cfs, _jx7.si, _jx8.cfe, _jx8.cfs, _jx8.si, _jx9.cfe, 
_jx9.cfs, _jx9.si, _jxa.cfe, _jxa.cfs, _jxa.si, _jxb.cfe, _jxb.cfs, _jxb.si, 
_jxc.cfe, _jxc.cfs, _jxc.si, _jxd.cfe, _jxd.cfs, _jxd.si, _jxe.cfe, _jxe.cfs, 
_jxe.si, _jxf.cfe, _jxf.cfs, _jxf.si, _jxg.cfe, _jxg.cfs, _jxg.si, _jxh.cfe, 
_jxh.cfs, _jxh.si, _jxi.cfe, _jxi.cfs, _jxi.si, _jxj.cfe, _jxj.cfs, _jxj.si, 
_jxk.cfe, _jxk.cfs, _jxk.si, _jxm.cfe, _jxm.cfs, _jxm.si, _jxn.cfe, _jxn.cfs, 
_jxn.si, _jxo.cfe, _jxo.cfs, _jxo.si, _jxp.cfe, _jxp.cfs, _jxp.si, _jxq.cfe, 
_jxq.cfs, _jxq.si, _jxr.cfe, _jxr.cfs, _jxr.si, _jxs.cfe, _jxs.cfs, _jxs.si, 
_jxt.cfe, _jxt.cfs, _jxt.si, _jxu.cfe, _jxu.cfs, _jxu.si, _jxv.cfe, _jxv.cfs, 
_jxv.si, _jxw.cfe, _jxw.cfs, _jxw.si, _jxx.cfe, _jxx.cfs, _jxx.si, _jxy.cfe, 
_jxy.cfs, _jxy.si, _jxz.cfe, _jxz.cfs, _jxz.si, _jy0.cfe, _jy0.cfs, _jy0.si, 
_jy1.cfe, _jy1.cfs, _jy1.si, _jy2.cfe, _jy2.cfs, _jy2.si, _jy3.cfe, _jy3.cfs, 
_jy3.si, _jy4.cfe, _jy4.cfs, _jy4.si, _jy5.cfe, _jy5.cfs, _jy5.si, _jy6.cfe, 
_jy6.cfs, _jy6.si, _jy7.cfe, _jy7.cfs, _jy7.si, _jy8.cfe, _jy8.cfs, _jy8.si, 
_jy9.cfe, _jy9.cfs, _jy9.si, _jya.cfe, _jya.cfs, _jya.si, _jyb.cfe, _jyb.cfs, 
_jyb.si, _jyc.cfe, _jyc.cfs, _jyc.si, segments_2]}, 
{indexVersion=1497614187568,generation=3,filelist=[_6wd.fdt, _6wd.fdx, 
_6wd.fnm, _6wd.nvd, _6wd.nvm, _6wd.si, _6wd_Lucene50_0.doc, 
_6wd_Lucene50_0.tim, _6wd_Lucene50_0.tip, _dpe.fdt, _dpe.fdx, _dpe.fnm, 
_dpe.nvd, _dpe.nvm, _dpe.si, _dpe_Lucene50_0.doc, _dpe_Lucene50_0.tim, 
_dpe_Lucene50_0.tip, _jxk.cfe, _jxk.cfs, _jxk.si, _jxl.fdt, _jxl.fdx, _jxl.fnm, 
_jxl.nvd, _jxl.nvm, _jxl.si, _jxl_Lucene50_0.doc, _jxl_Lucene50_0.tim, 
_jxl_Lucene50_0.tip, _jxm.cfe, _jxm.cfs, _jxm.si, _jxn.cfe, _jxn.cfs, _jxn.si, 
_jxo.cfe, _jxo.cfs, _jxo.si, _jxp.cfe, _jxp.cfs, _jxp.si, _jxq.cfe, _jxq.cfs, 
_jxq.si, _jxr.cfe, _jxr.cfs, _jxr.si, _jxs.cfe, _jxs.cfs, _jxs.si, _jxt.cfe, 
_jxt.cfs, _jxt.si, _jxu.cfe, _jxu.cfs, _jxu.si, _jxv.cfe, _jxv.cfs, _jxv.si, 
_jxw.cfe, _jxw.cfs, _jxw.si, _jxx.cfe, _jxx.cfs, _jxx.si, _jxy.cfe, _jxy.cfs, 
_jxy.si, _jxz.cfe, _jxz.cfs, _jxz.si, _jy0.cfe, _jy0.cfs, _jy0.si, _jy1.cfe, 
_jy1.cfs, _jy1.si, _jy2.cfe, _jy2.cfs, _jy2.si, _jy3.cfe, _jy3.cfs, _jy3.si, 
_jy4.cfe, _jy4.cfs, _jy4.si, _jy5.cfe, _jy5.cfs, _jy5.si, _jy6.cfe, _jy6.cfs, 
_jy6.si, _jy7.cfe, _jy7.cfs, _jy7.si, _jy8.cfe, _jy8.cfs, _jy8.si, _jy9.cfe, 
_jy9.cfs, _jy9.si, _jya.cfe, _jya.cfs, _jya.si, _jyb.cfe, _jyb.cfs, _jyb.si, 
_jyc.cfe, _jyc.cfs, _jyc.si, segments_3]}]>

Stack Trace:
java.lang.AssertionError: 
expected:<[{indexVersion=1497614187568,generation=2,filelist=[_6wd.fdt, 
_6wd.fdx, _6wd.fnm, _6wd.nvd, _6wd.nvm, _6wd.si, _6wd_Lucene50_0.doc, 
_6wd_Lucene50_0.tim, _6wd_Lucene50_0.tip, _dpe.fdt, _dpe.fdx, _dpe.fnm, 
_dpe.nvd, _dpe.nvm, _dpe.si, _dpe_Lucene50_0.doc, _dpe_Lucene50_0.tim, 
_dpe_Lucene50_0.tip, _jvx.fdt, _jvx.fdx, _jvx.fnm, _jvx.nvd, _jvx.nvm, _jvx.si, 
_jvx_Lucene50_0.doc, _jvx_Lucene50_0.tim, _jvx_Lucene50_0.tip, _jwr.cfe, 
_jwr.cfs, _jwr.si, _jws.fdt, _jws.fdx, _jws.fnm, _jws.nvd, _jws.nvm, _jws.si, 
_jws_Lucene50_0.doc, _jws_Lucene50_0.tim, _jws_Lucene50_0.tip, _jwt.cfe, 
_jwt.cfs, _jwt.si, _jwu.cfe, _jwu.cfs, _jwu.si, _jwv.cfe, _jwv.cfs, _jwv.si, 
_jww.cfe, _jww.cfs, _jww.si, _jwx.cfe, _jwx.cfs, _jwx.si, _jwy.cfe, _jwy.cfs, 
_jwy.si, _jwz.cfe, _jwz.cfs, _jwz.si, _jx0.cfe, _jx0.cfs, _jx0.si, _jx1.cfe, 
_jx1.cfs, _jx1.si, _jx2.cfe, _jx2.cfs, _jx2.si, _jx3.cfe, _jx3.cfs, _jx3.si, 
_jx4.cfe, _jx4.cfs, _jx4.si, _jx5.cfe, _jx5.cfs, _jx5.si, _jx6.cfe, _jx6.cfs, 
_jx6.si, _jx7.cfe, _jx7.cfs, _jx7.si, _jx8.cfe, _jx8.cfs, _jx8.si, _jx9.cfe, 
_jx9.cfs, _jx9.si, _jxa.cfe, _jxa.cfs, _jxa.si, _jxb.cfe, _jxb.cfs, _jxb.si, 
_jxc.cfe, _jxc.cfs, _jxc.si, _jxd.cfe, _jxd.cfs, _jxd.si, _jxe.cfe, _jxe.cfs, 
_jxe.si, _jxf.cfe, _jxf.cfs, _jxf.si, _jxg.cfe, _jxg.cfs, _jxg.si, _jxh.cfe, 
_jxh.cfs, _jxh.si, _jxi.cfe, _jxi.cfs, _jxi.si, _jxj.cfe, _jxj.cfs, _jxj.si, 
_jxk.cfe, _jxk.cfs, _jxk.si, _jxm.cfe, _jxm.cfs, _jxm.si, _jxn.cfe, _jxn.cfs, 
_jxn.si, _jxo.cfe, _jxo.cfs, _jxo.si, _jxp.cfe, _jxp.cfs, _jxp.si, _jxq.cfe, 
_jxq.cfs, _jxq.si, _jxr.cfe, _jxr.cfs, _jxr.si, _jxs.cfe, _jxs.cfs, _jxs.si, 
_jxt.cfe, _jxt.cfs, _jxt.si, _jxu.cfe, _jxu.cfs, _jxu.si, _jxv.cfe, _jxv.cfs, 
_jxv.si, _jxw.cfe, _jxw.cfs, _jxw.si, _jxx.cfe, _jxx.cfs, _jxx.si, _jxy.cfe, 
_jxy.cfs, _jxy.si, _jxz.cfe, _jxz.cfs, _jxz.si, _jy0.cfe, _jy0.cfs, _jy0.si, 
_jy1.cfe, _jy1.cfs, _jy1.si, _jy2.cfe, _jy2.cfs, _jy2.si, _jy3.cfe, _jy3.cfs, 
_jy3.si, _jy4.cfe, _jy4.cfs, _jy4.si, _jy5.cfe, _jy5.cfs, _jy5.si, _jy6.cfe, 
_jy6.cfs, _jy6.si, _jy7.cfe, _jy7.cfs, _jy7.si, _jy8.cfe, _jy8.cfs, _jy8.si, 
_jy9.cfe, _jy9.cfs, _jy9.si, _jya.cfe, _jya.cfs, _jya.si, _jyb.cfe, _jyb.cfs, 
_jyb.si, _jyc.cfe, _jyc.cfs, _jyc.si, segments_2]}]> but 
was:<[{indexVersion=1497614187568,generation=2,filelist=[_6wd.fdt, _6wd.fdx, 
_6wd.fnm, _6wd.nvd, _6wd.nvm, _6wd.si, _6wd_Lucene50_0.doc, 
_6wd_Lucene50_0.tim, _6wd_Lucene50_0.tip, _dpe.fdt, _dpe.fdx, _dpe.fnm, 
_dpe.nvd, _dpe.nvm, _dpe.si, _dpe_Lucene50_0.doc, _dpe_Lucene50_0.tim, 
_dpe_Lucene50_0.tip, _jvx.fdt, _jvx.fdx, _jvx.fnm, _jvx.nvd, _jvx.nvm, _jvx.si, 
_jvx_Lucene50_0.doc, _jvx_Lucene50_0.tim, _jvx_Lucene50_0.tip, _jwr.cfe, 
_jwr.cfs, _jwr.si, _jws.fdt, _jws.fdx, _jws.fnm, _jws.nvd, _jws.nvm, _jws.si, 
_jws_Lucene50_0.doc, _jws_Lucene50_0.tim, _jws_Lucene50_0.tip, _jwt.cfe, 
_jwt.cfs, _jwt.si, _jwu.cfe, _jwu.cfs, _jwu.si, _jwv.cfe, _jwv.cfs, _jwv.si, 
_jww.cfe, _jww.cfs, _jww.si, _jwx.cfe, _jwx.cfs, _jwx.si, _jwy.cfe, _jwy.cfs, 
_jwy.si, _jwz.cfe, _jwz.cfs, _jwz.si, _jx0.cfe, _jx0.cfs, _jx0.si, _jx1.cfe, 
_jx1.cfs, _jx1.si, _jx2.cfe, _jx2.cfs, _jx2.si, _jx3.cfe, _jx3.cfs, _jx3.si, 
_jx4.cfe, _jx4.cfs, _jx4.si, _jx5.cfe, _jx5.cfs, _jx5.si, _jx6.cfe, _jx6.cfs, 
_jx6.si, _jx7.cfe, _jx7.cfs, _jx7.si, _jx8.cfe, _jx8.cfs, _jx8.si, _jx9.cfe, 
_jx9.cfs, _jx9.si, _jxa.cfe, _jxa.cfs, _jxa.si, _jxb.cfe, _jxb.cfs, _jxb.si, 
_jxc.cfe, _jxc.cfs, _jxc.si, _jxd.cfe, _jxd.cfs, _jxd.si, _jxe.cfe, _jxe.cfs, 
_jxe.si, _jxf.cfe, _jxf.cfs, _jxf.si, _jxg.cfe, _jxg.cfs, _jxg.si, _jxh.cfe, 
_jxh.cfs, _jxh.si, _jxi.cfe, _jxi.cfs, _jxi.si, _jxj.cfe, _jxj.cfs, _jxj.si, 
_jxk.cfe, _jxk.cfs, _jxk.si, _jxm.cfe, _jxm.cfs, _jxm.si, _jxn.cfe, _jxn.cfs, 
_jxn.si, _jxo.cfe, _jxo.cfs, _jxo.si, _jxp.cfe, _jxp.cfs, _jxp.si, _jxq.cfe, 
_jxq.cfs, _jxq.si, _jxr.cfe, _jxr.cfs, _jxr.si, _jxs.cfe, _jxs.cfs, _jxs.si, 
_jxt.cfe, _jxt.cfs, _jxt.si, _jxu.cfe, _jxu.cfs, _jxu.si, _jxv.cfe, _jxv.cfs, 
_jxv.si, _jxw.cfe, _jxw.cfs, _jxw.si, _jxx.cfe, _jxx.cfs, _jxx.si, _jxy.cfe, 
_jxy.cfs, _jxy.si, _jxz.cfe, _jxz.cfs, _jxz.si, _jy0.cfe, _jy0.cfs, _jy0.si, 
_jy1.cfe, _jy1.cfs, _jy1.si, _jy2.cfe, _jy2.cfs, _jy2.si, _jy3.cfe, _jy3.cfs, 
_jy3.si, _jy4.cfe, _jy4.cfs, _jy4.si, _jy5.cfe, _jy5.cfs, _jy5.si, _jy6.cfe, 
_jy6.cfs, _jy6.si, _jy7.cfe, _jy7.cfs, _jy7.si, _jy8.cfe, _jy8.cfs, _jy8.si, 
_jy9.cfe, _jy9.cfs, _jy9.si, _jya.cfe, _jya.cfs, _jya.si, _jyb.cfe, _jyb.cfs, 
_jyb.si, _jyc.cfe, _jyc.cfs, _jyc.si, segments_2]}, 
{indexVersion=1497614187568,generation=3,filelist=[_6wd.fdt, _6wd.fdx, 
_6wd.fnm, _6wd.nvd, _6wd.nvm, _6wd.si, _6wd_Lucene50_0.doc, 
_6wd_Lucene50_0.tim, _6wd_Lucene50_0.tip, _dpe.fdt, _dpe.fdx, _dpe.fnm, 
_dpe.nvd, _dpe.nvm, _dpe.si, _dpe_Lucene50_0.doc, _dpe_Lucene50_0.tim, 
_dpe_Lucene50_0.tip, _jxk.cfe, _jxk.cfs, _jxk.si, _jxl.fdt, _jxl.fdx, _jxl.fnm, 
_jxl.nvd, _jxl.nvm, _jxl.si, _jxl_Lucene50_0.doc, _jxl_Lucene50_0.tim, 
_jxl_Lucene50_0.tip, _jxm.cfe, _jxm.cfs, _jxm.si, _jxn.cfe, _jxn.cfs, _jxn.si, 
_jxo.cfe, _jxo.cfs, _jxo.si, _jxp.cfe, _jxp.cfs, _jxp.si, _jxq.cfe, _jxq.cfs, 
_jxq.si, _jxr.cfe, _jxr.cfs, _jxr.si, _jxs.cfe, _jxs.cfs, _jxs.si, _jxt.cfe, 
_jxt.cfs, _jxt.si, _jxu.cfe, _jxu.cfs, _jxu.si, _jxv.cfe, _jxv.cfs, _jxv.si, 
_jxw.cfe, _jxw.cfs, _jxw.si, _jxx.cfe, _jxx.cfs, _jxx.si, _jxy.cfe, _jxy.cfs, 
_jxy.si, _jxz.cfe, _jxz.cfs, _jxz.si, _jy0.cfe, _jy0.cfs, _jy0.si, _jy1.cfe, 
_jy1.cfs, _jy1.si, _jy2.cfe, _jy2.cfs, _jy2.si, _jy3.cfe, _jy3.cfs, _jy3.si, 
_jy4.cfe, _jy4.cfs, _jy4.si, _jy5.cfe, _jy5.cfs, _jy5.si, _jy6.cfe, _jy6.cfs, 
_jy6.si, _jy7.cfe, _jy7.cfs, _jy7.si, _jy8.cfe, _jy8.cfs, _jy8.si, _jy9.cfe, 
_jy9.cfs, _jy9.si, _jya.cfe, _jya.cfs, _jya.si, _jyb.cfe, _jyb.cfs, _jyb.si, 
_jyc.cfe, _jyc.cfs, _jyc.si, segments_3]}]>
        at 
__randomizedtesting.SeedInfo.seed([B693392A06F62FF5:9344221A76BE21F6]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.failNotEquals(Assert.java:647)
        at org.junit.Assert.assertEquals(Assert.java:128)
        at org.junit.Assert.assertEquals(Assert.java:147)
        at 
org.apache.solr.handler.TestReplicationHandler.doTestReplicateAfterCoreReload(TestReplicationHandler.java:1279)
        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 
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:748)


FAILED:  
org.apache.solr.update.processor.UpdateRequestProcessorFactoryTest.testRequestTimeUrp

Error Message:
No such processor Template

Stack Trace:
org.apache.solr.common.SolrException: No such processor Template
        at 
__randomizedtesting.SeedInfo.seed([B693392A06F62FF5:132179E2A0B8E601]:0)
        at 
org.apache.solr.update.processor.UpdateRequestProcessorChain.getReqProcessors(UpdateRequestProcessorChain.java:284)
        at 
org.apache.solr.update.processor.UpdateRequestProcessorChain.constructChain(UpdateRequestProcessorChain.java:236)
        at 
org.apache.solr.core.SolrCore.getUpdateProcessorChain(SolrCore.java:1446)
        at 
org.apache.solr.update.processor.UpdateRequestProcessorFactoryTest.testRequestTimeUrp(UpdateRequestProcessorFactoryTest.java:54)
        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 
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:748)




Build Log:
[...truncated 11499 lines...]
   [junit4] Suite: org.apache.solr.cloud.CollectionsAPISolrJTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_B693392A06F62FF5-001/init-core-data-001
   [junit4]   2> 0    INFO  
(SUITE-CollectionsAPISolrJTest-seed#[B693392A06F62FF5]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using TrieFields
   [junit4]   2> 93   INFO  
(SUITE-CollectionsAPISolrJTest-seed#[B693392A06F62FF5]-worker) [    ] 
o.e.j.u.log Logging initialized @7288ms
   [junit4]   2> 100  INFO  
(SUITE-CollectionsAPISolrJTest-seed#[B693392A06F62FF5]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 680  INFO  
(SUITE-CollectionsAPISolrJTest-seed#[B693392A06F62FF5]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_B693392A06F62FF5-001/tempDir-001
   [junit4]   2> 694  INFO  
(SUITE-CollectionsAPISolrJTest-seed#[B693392A06F62FF5]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 705  INFO  (Thread-1) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 706  INFO  (Thread-1) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 905  INFO  
(SUITE-CollectionsAPISolrJTest-seed#[B693392A06F62FF5]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:55216
   [junit4]   2> 1006 ERROR (Thread-1) [    ] 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> 1306 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x15cb0937f210000, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 1685 INFO  (jetty-launcher-1-thread-1) [    ] o.e.j.s.Server 
jetty-9.3.14.v20161028
   [junit4]   2> 1699 INFO  (jetty-launcher-1-thread-2) [    ] o.e.j.s.Server 
jetty-9.3.14.v20161028
   [junit4]   2> 1696 INFO  (jetty-launcher-1-thread-4) [    ] o.e.j.s.Server 
jetty-9.3.14.v20161028
   [junit4]   2> 1702 INFO  (jetty-launcher-1-thread-3) [    ] o.e.j.s.Server 
jetty-9.3.14.v20161028
   [junit4]   2> 1827 INFO  (jetty-launcher-1-thread-4) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@446762e3{/solr,null,AVAILABLE}
   [junit4]   2> 1828 INFO  (jetty-launcher-1-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@557a21c1{/solr,null,AVAILABLE}
   [junit4]   2> 1828 INFO  (jetty-launcher-1-thread-3) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@6e206c47{/solr,null,AVAILABLE}
   [junit4]   2> 1852 INFO  (jetty-launcher-1-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@5a676fe8{/solr,null,AVAILABLE}
   [junit4]   2> 1903 INFO  (jetty-launcher-1-thread-2) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@47a77e40{SSL,[ssl, 
http/1.1]}{127.0.0.1:53224}
   [junit4]   2> 1904 INFO  (jetty-launcher-1-thread-2) [    ] o.e.j.s.Server 
Started @9120ms
   [junit4]   2> 1904 INFO  (jetty-launcher-1-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=53224}
   [junit4]   2> 1906 INFO  (jetty-launcher-1-thread-3) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@670b2d8d{SSL,[ssl, 
http/1.1]}{127.0.0.1:39510}
   [junit4]   2> 1910 INFO  (jetty-launcher-1-thread-3) [    ] o.e.j.s.Server 
Started @9126ms
   [junit4]   2> 1906 INFO  (jetty-launcher-1-thread-4) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@77810329{SSL,[ssl, 
http/1.1]}{127.0.0.1:55091}
   [junit4]   2> 1910 INFO  (jetty-launcher-1-thread-4) [    ] o.e.j.s.Server 
Started @9126ms
   [junit4]   2> 1907 INFO  (jetty-launcher-1-thread-1) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@7c5cd58f{SSL,[ssl, 
http/1.1]}{127.0.0.1:34108}
   [junit4]   2> 1911 INFO  (jetty-launcher-1-thread-1) [    ] o.e.j.s.Server 
Started @9127ms
   [junit4]   2> 1910 INFO  (jetty-launcher-1-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=39510}
   [junit4]   2> 1910 INFO  (jetty-launcher-1-thread-4) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=55091}
   [junit4]   2> 1912 INFO  (jetty-launcher-1-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=34108}
   [junit4]   2> 1959 ERROR (jetty-launcher-1-thread-2) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1959 ERROR (jetty-launcher-1-thread-3) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1959 ERROR (jetty-launcher-1-thread-1) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1959 ERROR (jetty-launcher-1-thread-4) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1966 INFO  (jetty-launcher-1-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 1960 INFO  (jetty-launcher-1-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 1959 INFO  (jetty-launcher-1-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 1972 INFO  (jetty-launcher-1-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1973 INFO  (jetty-launcher-1-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1976 INFO  (jetty-launcher-1-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1976 INFO  (jetty-launcher-1-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1967 INFO  (jetty-launcher-1-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 1976 INFO  (jetty-launcher-1-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1976 INFO  (jetty-launcher-1-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1984 INFO  (jetty-launcher-1-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1984 INFO  (jetty-launcher-1-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2001 INFO  (jetty-launcher-1-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-06-16T11:04:36.483Z
   [junit4]   2> 2003 INFO  (jetty-launcher-1-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-06-16T11:04:36.475Z
   [junit4]   2> 2003 INFO  (jetty-launcher-1-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-06-16T11:04:36.475Z
   [junit4]   2> 2017 INFO  (jetty-launcher-1-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-06-16T11:04:36.473Z
   [junit4]   2> 2051 INFO  (jetty-launcher-1-thread-3) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 2192 INFO  (jetty-launcher-1-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2195 INFO  (jetty-launcher-1-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2195 INFO  (jetty-launcher-1-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2202 INFO  (jetty-launcher-1-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2472 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x15cb0937f210001, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 2482 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x15cb0937f210004, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 3067 INFO  (jetty-launcher-1-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:55216/solr
   [junit4]   2> 3075 INFO  (jetty-launcher-1-thread-3) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:55216/solr
   [junit4]   2> 3075 INFO  (jetty-launcher-1-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:55216/solr
   [junit4]   2> 3075 INFO  (jetty-launcher-1-thread-4) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:55216/solr
   [junit4]   2> 3605 INFO  (jetty-launcher-1-thread-2) [n:127.0.0.1:53224_solr 
   ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 3605 INFO  (jetty-launcher-1-thread-1) [n:127.0.0.1:34108_solr 
   ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 3611 INFO  (jetty-launcher-1-thread-4) [n:127.0.0.1:55091_solr 
   ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 3615 INFO  (jetty-launcher-1-thread-2) [n:127.0.0.1:53224_solr 
   ] o.a.s.c.OverseerElectionContext I am going to be the leader 
127.0.0.1:53224_solr
   [junit4]   2> 3615 INFO  (jetty-launcher-1-thread-3) [n:127.0.0.1:39510_solr 
   ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 3622 INFO  (jetty-launcher-1-thread-2) [n:127.0.0.1:53224_solr 
   ] o.a.s.c.Overseer Overseer 
(id=98147439434858508-127.0.0.1:53224_solr-n_0000000000) starting
   [junit4]   2> 3642 INFO  (jetty-launcher-1-thread-1) [n:127.0.0.1:34108_solr 
   ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:34108_solr
   [junit4]   2> 3642 INFO  (jetty-launcher-1-thread-3) [n:127.0.0.1:39510_solr 
   ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:39510_solr
   [junit4]   2> 3660 INFO  
(zkCallback-23-thread-1-processing-n:127.0.0.1:53224_solr) 
[n:127.0.0.1:53224_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 3660 INFO  
(zkCallback-20-thread-1-processing-n:127.0.0.1:39510_solr) 
[n:127.0.0.1:39510_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 3669 INFO  
(zkCallback-21-thread-1-processing-n:127.0.0.1:34108_solr) 
[n:127.0.0.1:34108_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 3669 INFO  
(zkCallback-22-thread-1-processing-n:127.0.0.1:55091_solr) 
[n:127.0.0.1:55091_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 3688 INFO  (jetty-launcher-1-thread-4) [n:127.0.0.1:55091_solr 
   ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:55091_solr
   [junit4]   2> 3692 INFO  
(zkCallback-23-thread-1-processing-n:127.0.0.1:53224_solr) 
[n:127.0.0.1:53224_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 3693 INFO  
(zkCallback-21-thread-1-processing-n:127.0.0.1:34108_solr) 
[n:127.0.0.1:34108_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 3693 INFO  
(zkCallback-20-thread-1-processing-n:127.0.0.1:39510_solr) 
[n:127.0.0.1:39510_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 3694 INFO  
(zkCallback-22-thread-1-processing-n:127.0.0.1:55091_solr) 
[n:127.0.0.1:55091_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 4125 INFO  (jetty-launcher-1-thread-2) [n:127.0.0.1:53224_solr 
   ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:53224_solr
   [junit4]   2> 4129 INFO  
(zkCallback-20-thread-1-processing-n:127.0.0.1:39510_solr) 
[n:127.0.0.1:39510_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 4129 INFO  
(zkCallback-21-thread-1-processing-n:127.0.0.1:34108_solr) 
[n:127.0.0.1:34108_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 4129 INFO  
(zkCallback-22-thread-1-processing-n:127.0.0.1:55091_solr) 
[n:127.0.0.1:55091_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 4130 INFO  
(zkCallback-23-thread-1-processing-n:127.0.0.1:53224_solr) 
[n:127.0.0.1:53224_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 4747 INFO  (jetty-launcher-1-thread-2) [n:127.0.0.1:53224_solr 
   ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_53224.solr.node' 
(registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@377b1f4c
   [junit4]   2> 4749 INFO  (jetty-launcher-1-thread-2) [n:127.0.0.1:53224_solr 
   ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_53224.solr.jvm' 
(registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@377b1f4c
   [junit4]   2> 4749 INFO  (jetty-launcher-1-thread-2) [n:127.0.0.1:53224_solr 
   ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_53224.solr.jetty' 
(registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@377b1f4c
   [junit4]   2> 4751 INFO  (jetty-launcher-1-thread-4) [n:127.0.0.1:55091_solr 
   ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_55091.solr.node' 
(registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@377b1f4c
   [junit4]   2> 4756 INFO  (jetty-launcher-1-thread-4) [n:127.0.0.1:55091_solr 
   ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_55091.solr.jvm' 
(registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@377b1f4c
   [junit4]   2> 4756 INFO  (jetty-launcher-1-thread-4) [n:127.0.0.1:55091_solr 
   ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_55091.solr.jetty' 
(registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@377b1f4c
   [junit4]   2> 4764 INFO  (jetty-launcher-1-thread-3) [n:127.0.0.1:39510_solr 
   ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39510.solr.node' 
(registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@377b1f4c
   [junit4]   2> 4765 INFO  (jetty-launcher-1-thread-3) [n:127.0.0.1:39510_solr 
   ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39510.solr.jvm' 
(registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@377b1f4c
   [junit4]   2> 4765 INFO  (jetty-launcher-1-thread-3) [n:127.0.0.1:39510_solr 
   ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39510.solr.jetty' 
(registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@377b1f4c
   [junit4]   2> 4766 INFO  (jetty-launcher-1-thread-1) [n:127.0.0.1:34108_solr 
   ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34108.solr.node' 
(registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@377b1f4c
   [junit4]   2> 4766 INFO  (jetty-launcher-1-thread-1) [n:127.0.0.1:34108_solr 
   ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34108.solr.jvm' 
(registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@377b1f4c
   [junit4]   2> 4766 INFO  (jetty-launcher-1-thread-1) [n:127.0.0.1:34108_solr 
   ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34108.solr.jetty' 
(registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@377b1f4c
   [junit4]   2> 4852 INFO  (jetty-launcher-1-thread-1) [n:127.0.0.1:34108_solr 
   ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_B693392A06F62FF5-001/tempDir-001/node1/.
   [junit4]   2> 4856 INFO  (jetty-launcher-1-thread-2) [n:127.0.0.1:53224_solr 
   ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_B693392A06F62FF5-001/tempDir-001/node2/.
   [junit4]   2> 4893 INFO  (jetty-launcher-1-thread-4) [n:127.0.0.1:55091_solr 
   ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_B693392A06F62FF5-001/tempDir-001/node4/.
   [junit4]   2> 4912 INFO  (jetty-launcher-1-thread-3) [n:127.0.0.1:39510_solr 
   ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_B693392A06F62FF5-001/tempDir-001/node3/.
   [junit4]   2> 5498 INFO  
(SUITE-CollectionsAPISolrJTest-seed#[B693392A06F62FF5]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 5501 INFO  
(SUITE-CollectionsAPISolrJTest-seed#[B693392A06F62FF5]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:55216/solr ready
   [junit4]   2> 5593 INFO  
(TEST-CollectionsAPISolrJTest.testCreateCollectionWithPropertyParam-seed#[B693392A06F62FF5])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testCreateCollectionWithPropertyParam
   [junit4]   2> 6440 INFO  (qtp895565924-43) [n:127.0.0.1:34108_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=1&property.ulogDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_B693392A06F62FF5-001/testPropertyParamsForCreate-001/ulogDir-ggg&property.dataDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_B693392A06F62FF5-001/testPropertyParamsForCreate-001/dataDir-sx&collection.configName=conf&name=solrj_test_core_props&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 6640 INFO  
(OverseerThreadFactory-18-thread-1-processing-n:127.0.0.1:53224_solr) 
[n:127.0.0.1:53224_solr    ] o.a.s.c.CreateCollectionCmd Create collection 
solrj_test_core_props
   [junit4]   2> 6930 INFO  (qtp1763107271-48) [n:127.0.0.1:53224_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&property.dataDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_B693392A06F62FF5-001/testPropertyParamsForCreate-001/dataDir-sx&collection.configName=conf&newCollection=true&collection=solrj_test_core_props&version=2&replicaType=NRT&property.ulogDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_B693392A06F62FF5-001/testPropertyParamsForCreate-001/ulogDir-ggg&name=solrj_test_core_props_shard1_replica_n1&action=CREATE&numShards=1&shard=shard1&wt=javabin
   [junit4]   2> 6943 INFO  (qtp1763107271-48) [n:127.0.0.1:53224_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 7092 INFO  
(zkCallback-23-thread-1-processing-n:127.0.0.1:53224_solr) 
[n:127.0.0.1:53224_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_test_core_props/state.json] for collection 
[solrj_test_core_props] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 8091 INFO  (qtp1763107271-48) [n:127.0.0.1:53224_solr 
c:solrj_test_core_props s:shard1  x:solrj_test_core_props_shard1_replica_n1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 8243 INFO  (qtp1763107271-48) [n:127.0.0.1:53224_solr 
c:solrj_test_core_props s:shard1  x:solrj_test_core_props_shard1_replica_n1] 
o.a.s.s.IndexSchema [solrj_test_core_props_shard1_replica_n1] Schema 
name=minimal
   [junit4]   2> 8454 INFO  (qtp1763107271-48) [n:127.0.0.1:53224_solr 
c:solrj_test_core_props s:shard1  x:solrj_test_core_props_shard1_replica_n1] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 8455 INFO  (qtp1763107271-48) [n:127.0.0.1:53224_solr 
c:solrj_test_core_props s:shard1  x:solrj_test_core_props_shard1_replica_n1] 
o.a.s.c.CoreContainer Creating SolrCore 
'solrj_test_core_props_shard1_replica_n1' using configuration from collection 
solrj_test_core_props, trusted=true
   [junit4]   2> 8485 INFO  (qtp1763107271-48) [n:127.0.0.1:53224_solr 
c:solrj_test_core_props s:shard1  x:solrj_test_core_props_shard1_replica_n1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_53224.solr.core.solrj_test_core_props.shard1.replica_n1' (registry 
'solr.core.solrj_test_core_props.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@377b1f4c
   [junit4]   2> 8494 INFO  (qtp1763107271-48) [n:127.0.0.1:53224_solr 
c:solrj_test_core_props s:shard1  x:solrj_test_core_props_shard1_replica_n1] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 8520 INFO  (qtp1763107271-48) [n:127.0.0.1:53224_solr 
c:solrj_test_core_props s:shard1  x:solrj_test_core_props_shard1_replica_n1] 
o.a.s.c.SolrCore [[solrj_test_core_props_shard1_replica_n1] ] Opening new 
SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_B693392A06F62FF5-001/tempDir-001/node2/solrj_test_core_props_shard1_replica_n1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_B693392A06F62FF5-001/testPropertyParamsForCreate-001/dataDir-sx/]
   [junit4]   2> 10040 INFO  (qtp1763107271-48) [n:127.0.0.1:53224_solr 
c:solrj_test_core_props s:shard1  x:solrj_test_core_props_shard1_replica_n1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 10040 INFO  (qtp1763107271-48) [n:127.0.0.1:53224_solr 
c:solrj_test_core_props s:shard1  x:solrj_test_core_props_shard1_replica_n1] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 10062 INFO  (qtp1763107271-48) [n:127.0.0.1:53224_solr 
c:solrj_test_core_props s:shard1  x:solrj_test_core_props_shard1_replica_n1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 10063 INFO  (qtp1763107271-48) [n:127.0.0.1:53224_solr 
c:solrj_test_core_props s:shard1  x:solrj_test_core_props_shard1_replica_n1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 10100 INFO  (qtp1763107271-48) [n:127.0.0.1:53224_solr 
c:solrj_test_core_props s:shard1  x:solrj_test_core_props_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@217cbd82[solrj_test_core_props_shard1_replica_n1] main]
   [junit4]   2> 10157 INFO  (qtp1763107271-48) [n:127.0.0.1:53224_solr 
c:solrj_test_core_props s:shard1  x:solrj_test_core_props_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 10199 INFO  (qtp1763107271-48) [n:127.0.0.1:53224_solr 
c:solrj_test_core_props s:shard1  x:solrj_test_core_props_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 10310 INFO  (qtp1763107271-48) [n:127.0.0.1:53224_solr 
c:solrj_test_core_props s:shard1  x:solrj_test_core_props_shard1_replica_n1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 10535 INFO  
(searcherExecutor-27-thread-1-processing-n:127.0.0.1:53224_solr 
x:solrj_test_core_props_shard1_replica_n1 s:shard1 c:solrj_test_core_props) 
[n:127.0.0.1:53224_solr c:solrj_test_core_props s:shard1  
x:solrj_test_core_props_shard1_replica_n1] o.a.s.c.SolrCore 
[solrj_test_core_props_shard1_replica_n1] Registered new searcher 
Searcher@217cbd82[solrj_test_core_props_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 10540 INFO  (qtp1763107271-48) [n:127.0.0.1:53224_solr 
c:solrj_test_core_props s:shard1  x:solrj_test_core_props_shard1_replica_n1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1570359041105854464
   [junit4]   2> 10615 INFO  
(zkCallback-23-thread-1-processing-n:127.0.0.1:53224_solr) 
[n:127.0.0.1:53224_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_test_core_props/state.json] for collection 
[solrj_test_core_props] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 10622 INFO  (qtp1763107271-48) [n:127.0.0.1:53224_solr 
c:solrj_test_core_props s:shard1  x:solrj_test_core_props_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 10622 INFO  (qtp1763107271-48) [n:127.0.0.1:53224_solr 
c:solrj_test_core_props s:shard1  x:solrj_test_core_props_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 10623 INFO  (qtp1763107271-48) [n:127.0.0.1:53224_solr 
c:solrj_test_core_props s:shard1  x:solrj_test_core_props_shard1_replica_n1] 
o.a.s.c.SyncStrategy Sync replicas to 
https://127.0.0.1:53224/solr/solrj_test_core_props_shard1_replica_n1/
   [junit4]   2> 10640 INFO  (qtp1763107271-48) [n:127.0.0.1:53224_solr 
c:solrj_test_core_props s:shard1  x:solrj_test_core_props_shard1_replica_n1] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 10641 INFO  (qtp1763107271-48) [n:127.0.0.1:53224_solr 
c:solrj_test_core_props s:shard1  x:solrj_test_core_props_shard1_replica_n1] 
o.a.s.c.SyncStrategy 
https://127.0.0.1:53224/solr/solrj_test_core_props_shard1_replica_n1/ has no 
replicas
   [junit4]   2> 10641 INFO  (qtp1763107271-48) [n:127.0.0.1:53224_solr 
c:solrj_test_core_props s:shard1  x:solrj_test_core_props_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 10697 INFO  (qtp1763107271-48) [n:127.0.0.1:53224_solr 
c:solrj_test_core_props s:shard1  x:solrj_test_core_props_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:53224/solr/solrj_test_core_props_shard1_replica_n1/ shard1
   [junit4]   2> 10809 INFO  
(zkCallback-23-thread-1-processing-n:127.0.0.1:53224_solr) 
[n:127.0.0.1:53224_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_test_core_props/state.json] for collection 
[solrj_test_core_props] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 10832 INFO  (qtp1763107271-48) [n:127.0.0.1:53224_solr 
c:solrj_test_core_props s:shard1  x:solrj_test_core_props_shard1_replica_n1] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 10846 INFO  (qtp1763107271-48) [n:127.0.0.1:53224_solr 
c:solrj_test_core_props s:shard1  x:solrj_test_core_props_shard1_replica_n1] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&property.dataDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_B693392A06F62FF5-001/testPropertyParamsForCreate-001/dataDir-sx&collection.configName=conf&newCollection=true&collection=solrj_test_core_props&version=2&replicaType=NRT&property.ulogDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_B693392A06F62FF5-001/testPropertyParamsForCreate-001/ulogDir-ggg&name=solrj_test_core_props_shard1_replica_n1&action=CREATE&numShards=1&shard=shard1&wt=javabin}
 status=0 QTime=3924
   [junit4]   2> 10941 INFO  
(zkCallback-23-thread-1-processing-n:127.0.0.1:53224_solr) 
[n:127.0.0.1:53224_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/solrj_test_core_props/state.json] for collection 
[solrj_test_core_props] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 10950 INFO  (qtp895565924-43) [n:127.0.0.1:34108_solr    ] 
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 10952 INFO  (qtp895565924-43) [n:127.0.0.1:34108_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={replicationFactor=1&property.ulogDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_B693392A06F62FF5-001/testPropertyParamsForCreate-001/ulogDir-ggg&property.dataDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_B693392A06F62FF5-001/testPropertyParamsForCreate-001/dataDir-sx&collection.configName=conf&name=solrj_test_core_props&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2}
 status=0 QTime=4559
   [junit4]   2> 10987 INFO  (qtp1763107271-63) [n:127.0.0.1:53224_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={action=STATUS&indexInfo=true&wt=javabin&version=2} status=0 QTime=8
   [junit4]   2> 10991 INFO  
(TEST-CollectionsAPISolrJTest.testCreateCollectionWithPropertyParam-seed#[B693392A06F62FF5])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testCreateCollectionWithPropertyParam
   [junit4]   2> 11042 INFO  
(TEST-CollectionsAPISolrJTest.testOverseerStatus-seed#[B693392A06F62FF5]) [    
] o.a.s.SolrTestCaseJ4 ###Starting testOverseerStatus
   [junit4]   2> 11045 INFO  (qtp895565924-46) [n:127.0.0.1:34108_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :overseerstatus with 
params action=OVERSEERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 11081 INFO  
(OverseerCollectionConfigSetProcessor-98147439434858508-127.0.0.1:53224_solr-n_0000000000)
 [n:127.0.0.1:53224_solr    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000000 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 11202 INFO  (qtp895565924-46) [n:127.0.0.1:34108_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=OVERSEERSTATUS&wt=javabin&version=2} status=0 QTime=157
   [junit4]   2> 11205 INFO  
(TEST-CollectionsAPISolrJTest.testOverseerStatus-seed#[B693392A06F62FF5]) [    
] o.a.s.SolrTestCaseJ4 ###Ending testOverseerStatus
   [junit4]   2> 11207 INFO  
(OverseerCollectionConfigSetProcessor-98147439434858508-127.0.0.1:53224_solr-n_0000000000)
 [n:127.0.0.1:53224_solr    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000002 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 11252 INFO  
(TEST-CollectionsAPISolrJTest.testBalanceShardUnique-seed#[B693392A06F62FF5]) [ 
   ] o.a.s.SolrTestCaseJ4 ###Starting testBalanceShardUnique
   [junit4]   2> 11254 INFO  (qtp895565924-38) [n:127.0.0.1:34108_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=2&collection.configName=conf&name=balancedProperties&nrtReplicas=2&action=CREATE&numShards=2&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 11267 INFO  
(OverseerThreadFactory-18-thread-3-processing-n:127.0.0.1:53224_solr) 
[n:127.0.0.1:53224_solr    ] o.a.s.c.CreateCollectionCmd Create collection 
balancedProperties
   [junit4]   2> 11746 INFO  (qtp1763107271-64) [n:127.0.0.1:53224_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&name=balancedProperties_shard2_replica_n2&action=CREATE&numShards=2&collection=balancedProperties&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 11846 INFO  (qtp741489790-54) [n:127.0.0.1:55091_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&name=balancedProperties_shard2_replica_n1&action=CREATE&numShards=2&collection=balancedProperties&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 11847 INFO  (qtp741489790-54) [n:127.0.0.1:55091_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 11862 INFO  (qtp895565924-44) [n:127.0.0.1:34108_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&name=balancedProperties_shard1_replica_n2&action=CREATE&numShards=2&collection=balancedProperties&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 11863 INFO  (qtp895565924-44) [n:127.0.0.1:34108_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 11922 INFO  (qtp1423950514-35) [n:127.0.0.1:39510_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&name=balancedProperties_shard1_replica_n1&action=CREATE&numShards=2&collection=balancedProperties&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 11923 INFO  (qtp1423950514-35) [n:127.0.0.1:39510_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 12034 INFO  
(zkCallback-22-thread-1-processing-n:127.0.0.1:55091_solr) 
[n:127.0.0.1:55091_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 12034 INFO  
(zkCallback-23-thread-1-processing-n:127.0.0.1:53224_solr) 
[n:127.0.0.1:53224_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 12034 INFO  
(zkCallback-20-thread-1-processing-n:127.0.0.1:39510_solr) 
[n:127.0.0.1:39510_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 12035 INFO  
(zkCallback-21-thread-1-processing-n:127.0.0.1:34108_solr) 
[n:127.0.0.1:34108_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 12810 INFO  (qtp1763107271-64) [n:127.0.0.1:53224_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n2] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 12859 INFO  (qtp1763107271-64) [n:127.0.0.1:53224_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n2] 
o.a.s.s.IndexSchema [balancedProperties_shard2_replica_n2] Schema name=minimal
   [junit4]   2> 12871 INFO  (qtp1763107271-64) [n:127.0.0.1:53224_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n2] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 12871 INFO  (qtp1763107271-64) [n:127.0.0.1:53224_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n2] 
o.a.s.c.CoreContainer Creating SolrCore 'balancedProperties_shard2_replica_n2' 
using configuration from collection balancedProperties, trusted=true
   [junit4]   2> 12895 INFO  (qtp1763107271-64) [n:127.0.0.1:53224_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n2] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_53224.solr.core.balancedProperties.shard2.replica_n2' (registry 
'solr.core.balancedProperties.shard2.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@377b1f4c
   [junit4]   2> 12895 INFO  (qtp1763107271-64) [n:127.0.0.1:53224_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n2] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 12896 INFO  (qtp1763107271-64) [n:127.0.0.1:53224_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n2] 
o.a.s.c.SolrCore [[balancedProperties_shard2_replica_n2] ] Opening new SolrCore 
at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_B693392A06F62FF5-001/tempDir-001/node2/balancedProperties_shard2_replica_n2],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_B693392A06F62FF5-001/tempDir-001/node2/./balancedProperties_shard2_replica_n2/data/]
   [junit4]   2> 12903 INFO  (qtp741489790-54) [n:127.0.0.1:55091_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 12956 INFO  (qtp895565924-44) [n:127.0.0.1:34108_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n2] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 12984 INFO  (qtp741489790-54) [n:127.0.0.1:55091_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n1] 
o.a.s.s.IndexSchema [balancedProperties_shard2_replica_n1] Schema name=minimal
   [junit4]   2> 12996 INFO  (qtp1423950514-35) [n:127.0.0.1:39510_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 13015 INFO  (qtp741489790-54) [n:127.0.0.1:55091_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n1] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 13015 INFO  (qtp741489790-54) [n:127.0.0.1:55091_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n1] 
o.a.s.c.CoreContainer Creating SolrCore 'balancedProperties_shard2_replica_n1' 
using configuration from collection balancedProperties, trusted=true
   [junit4]   2> 13017 INFO  (qtp741489790-54) [n:127.0.0.1:55091_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_55091.solr.core.balancedProperties.shard2.replica_n1' (registry 
'solr.core.balancedProperties.shard2.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@377b1f4c
   [junit4]   2> 13017 INFO  (qtp741489790-54) [n:127.0.0.1:55091_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n1] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 13018 INFO  (qtp741489790-54) [n:127.0.0.1:55091_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n1] 
o.a.s.c.SolrCore [[balancedProperties_shard2_replica_n1] ] Opening new SolrCore 
at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_B693392A06F62FF5-001/tempDir-001/node4/balancedProperties_shard2_replica_n1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_B693392A06F62FF5-001/tempDir-001/node4/./balancedProperties_shard2_replica_n1/data/]
   [junit4]   2> 13031 INFO  (qtp1423950514-35) [n:127.0.0.1:39510_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n1] 
o.a.s.s.IndexSchema [balancedProperties_shard1_replica_n1] Schema name=minimal
   [junit4]   2> 13033 INFO  (qtp895565924-44) [n:127.0.0.1:34108_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n2] 
o.a.s.s.IndexSchema [balancedProperties_shard1_replica_n2] Schema name=minimal
   [junit4]   2> 13057 INFO  (qtp895565924-44) [n:127.0.0.1:34108_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n2] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 13057 INFO  (qtp895565924-44) [n:127.0.0.1:34108_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n2] 
o.a.s.c.CoreContainer Creating SolrCore 'balancedProperties_shard1_replica_n2' 
using configuration from collection balancedProperties, trusted=true
   [junit4]   2> 13059 INFO  (qtp895565924-44) [n:127.0.0.1:34108_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n2] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_34108.solr.core.balancedProperties.shard1.replica_n2' (registry 
'solr.core.balancedProperties.shard1.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@377b1f4c
   [junit4]   2> 13059 INFO  (qtp895565924-44) [n:127.0.0.1:34108_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n2] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 13059 INFO  (qtp895565924-44) [n:127.0.0.1:34108_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n2] 
o.a.s.c.SolrCore [[balancedProperties_shard1_replica_n2] ] Opening new SolrCore 
at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_B693392A06F62FF5-001/tempDir-001/node1/balancedProperties_shard1_replica_n2],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_B693392A06F62FF5-001/tempDir-001/node1/./balancedProperties_shard1_replica_n2/data/]
   [junit4]   2> 13066 INFO  (qtp1423950514-35) [n:127.0.0.1:39510_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n1] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 13066 INFO  (qtp1423950514-35) [n:127.0.0.1:39510_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n1] 
o.a.s.c.CoreContainer Creating SolrCore 'balancedProperties_shard1_replica_n1' 
using configuration from collection balancedProperties, trusted=true
   [junit4]   2> 13067 INFO  (qtp1423950514-35) [n:127.0.0.1:39510_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_39510.solr.core.balancedProperties.shard1.replica_n1' (registry 
'solr.core.balancedProperties.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@377b1f4c
   [junit4]   2> 13067 INFO  (qtp1423950514-35) [n:127.0.0.1:39510_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n1] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 13067 INFO  (qtp1423950514-35) [n:127.0.0.1:39510_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n1] 
o.a.s.c.SolrCore [[balancedProperties_shard1_replica_n1] ] Opening new SolrCore 
at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_B693392A06F62FF5-001/tempDir-001/node3/balancedProperties_shard1_replica_n1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_B693392A06F62FF5-001/tempDir-001/node3/./balancedProperties_shard1_replica_n1/data/]
   [junit4]   2> 13084 INFO  (qtp1763107271-64) [n:127.0.0.1:53224_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n2] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 13085 INFO  (qtp1763107271-64) [n:127.0.0.1:53224_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n2] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 13095 INFO  (qtp1763107271-64) [n:127.0.0.1:53224_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n2] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 13095 INFO  (qtp1763107271-64) [n:127.0.0.1:53224_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n2] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 13098 INFO  (qtp1763107271-64) [n:127.0.0.1:53224_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n2] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@60845bf3[balancedProperties_shard2_replica_n2] main]
   [junit4]   2> 13107 INFO  (qtp1763107271-64) [n:127.0.0.1:53224_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n2] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 13108 INFO  (qtp1763107271-64) [n:127.0.0.1:53224_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n2] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 13109 INFO  (qtp1763107271-64) [n:127.0.0.1:53224_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n2] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 13110 INFO  (qtp1763107271-64) [n:127.0.0.1:53224_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n2] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1570359043800694784
   [junit4]   2> 13114 INFO  
(searcherExecutor-32-thread-1-processing-n:127.0.0.1:53224_solr 
x:balancedProperties_shard2_replica_n2 s:shard2 c:balancedProperties) 
[n:127.0.0.1:53224_solr c:balancedProperties s:shard2  
x:balancedProperties_shard2_replica_n2] o.a.s.c.SolrCore 
[balancedProperties_shard2_replica_n2] Registered new searcher 
Searcher@60845bf3[balancedProperties_shard2_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 13125 INFO  (qtp1763107271-64) [n:127.0.0.1:53224_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n2] 
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for 
shard shard2: total=2 found=1 timeoutin=9999ms
   [junit4]   2> 13210 INFO  (qtp741489790-54) [n:127.0.0.1:55091_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 13210 INFO  (qtp741489790-54) [n:127.0.0.1:55091_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n1] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 13228 INFO  (qtp741489790-54) [n:127.0.0.1:55091_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 13228 INFO  (qtp741489790-54) [n:127.0.0.1:55091_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 13231 INFO  (qtp741489790-54) [n:127.0.0.1:55091_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@635c5e2a[balancedProperties_shard2_replica_n1] main]
   [junit4]   2> 13235 INFO  (qtp741489790-54) [n:127.0.0.1:55091_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 13235 INFO  (qtp741489790-54) [n:127.0.0.1:55091_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 13236 INFO  
(zkCallback-20-thread-1-processing-n:127.0.0.1:39510_solr) 
[n:127.0.0.1:39510_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 13237 INFO  
(zkCallback-23-thread-1-processing-n:127.0.0.1:53224_solr) 
[n:127.0.0.1:53224_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 13237 INFO  
(zkCallback-22-thread-1-processing-n:127.0.0.1:55091_solr) 
[n:127.0.0.1:55091_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 13237 INFO  
(zkCallback-21-thread-1-processing-n:127.0.0.1:34108_solr) 
[n:127.0.0.1:34108_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 13239 INFO  (qtp741489790-54) [n:127.0.0.1:55091_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 13243 INFO  
(searcherExecutor-33-thread-1-processing-n:127.0.0.1:55091_solr 
x:balancedProperties_shard2_replica_n1 s:shard2 c:balancedProperties) 
[n:127.0.0.1:55091_solr c:balancedProperties s:shard2  
x:balancedProperties_shard2_replica_n1] o.a.s.c.SolrCore 
[balancedProperties_shard2_replica_n1] Registered new searcher 
Searcher@635c5e2a[balancedProperties_shard2_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 13244 INFO  (qtp741489790-54) [n:127.0.0.1:55091_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1570359043941203968
   [junit4]   2> 13254 INFO  (qtp1423950514-35) [n:127.0.0.1:39510_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 13254 INFO  (qtp1423950514-35) [n:127.0.0.1:39510_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n1] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 13262 INFO  (qtp1423950514-35) [n:127.0.0.1:39510_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 13262 INFO  (qtp1423950514-35) [n:127.0.0.1:39510_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 13266 INFO  (qtp1423950514-35) [n:127.0.0.1:39510_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@43d2e908[balancedProperties_shard1_replica_n1] main]
   [junit4]   2> 13267 INFO  (qtp1423950514-35) [n:127.0.0.1:39510_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 13268 INFO  (qtp1423950514-35) [n:127.0.0.1:39510_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 13269 INFO  (qtp1423950514-35) [n:127.0.0.1:39510_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 13272 INFO  (qtp895565924-44) [n:127.0.0.1:34108_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n2] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 13272 INFO  (qtp895565924-44) [n:127.0.0.1:34108_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n2] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 13276 INFO  
(searcherExecutor-36-thread-1-processing-n:127.0.0.1:39510_solr 
x:balancedProperties_shard1_replica_n1 s:shard1 c:balancedProperties) 
[n:127.0.0.1:39510_solr c:balancedProperties s:shard1  
x:balancedProperties_shard1_replica_n1] o.a.s.c.SolrCore 
[balancedProperties_shard1_replica_n1] Registered new searcher 
Searcher@43d2e908[balancedProperties_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 13280 INFO  (qtp895565924-44) [n:127.0.0.1:34108_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n2] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 13281 INFO  (qtp895565924-44) [n:127.0.0.1:34108_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n2] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 13285 INFO  (qtp1423950514-35) [n:127.0.0.1:39510_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1570359043984195584
   [junit4]   2> 13289 INFO  (qtp895565924-44) [n:127.0.0.1:34108_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n2] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@3c960505[balancedProperties_shard1_replica_n2] main]
   [junit4]   2> 13294 INFO  (qtp895565924-44) [n:127.0.0.1:34108_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n2] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 13295 INFO  (qtp895565924-44) [n:127.0.0.1:34108_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n2] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 13296 INFO  (qtp895565924-44) [n:127.0.0.1:34108_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n2] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 13298 INFO  
(searcherExecutor-35-thread-1-processing-n:127.0.0.1:34108_solr 
x:balancedProperties_shard1_replica_n2 s:shard1 c:balancedProperties) 
[n:127.0.0.1:34108_solr c:balancedProperties s:shard1  
x:balancedProperties_shard1_replica_n2] o.a.s.c.SolrCore 
[balancedProperties_shard1_replica_n2] Registered new searcher 
Searcher@3c960505[balancedProperties_shard1_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 13302 INFO  (qtp895565924-44) [n:127.0.0.1:34108_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n2] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1570359044002021376
   [junit4]   2> 13423 INFO  (qtp895565924-44) [n:127.0.0.1:34108_solr 
c:balancedProperties s:shard1  x:balancedProperties_shard1_replica_n2] 
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for 
shard shard1: total=2 found=1 timeoutin=9999ms
   [junit4]   2> 13530 INFO  
(zkCallback-23-thread-1-processing-n:127.0.0.1:53224_solr) 
[n:127.0.0.1:53224_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 13530 INFO  
(zkCallback-20-thread-1-processing-n:127.0.0.1:39510_solr) 
[n:127.0.0.1:39510_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 13530 INFO  
(zkCallback-21-thread-1-processing-n:127.0.0.1:34108_solr) 
[n:127.0.0.1:34108_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 13530 INFO  
(zkCallback-22-thread-1-processing-n:127.0.0.1:55091_solr) 
[n:127.0.0.1:55091_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/balancedProperties/state.json] for collection 
[balancedProperties] has occurred - updating... (live nodes size: [4])
   [junit4]   2> 13633 INFO  (qtp1763107271-64) [n:127.0.0.1:53224_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n2] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 13633 INFO  (qtp1763107271-64) [n:127.0.0.1:53224_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n2] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 13633 INFO  (qtp1763107271-64) [n:127.0.0.1:53224_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n2] 
o.a.s.c.SyncStrategy Sync replicas to 
https://127.0.0.1:53224/solr/balancedProperties_shard2_replica_n2/
   [junit4]   2> 13640 INFO  (qtp1763107271-64) [n:127.0.0.1:53224_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n2] 
o.a.s.u.PeerSync PeerSync: core=balancedProperties_shard2_replica_n2 
url=https://127.0.0.1:53224/solr START 
replicas=[https://127.0.0.1:55091/solr/balancedProperties_shard2_replica_n1/] 
nUpdates=100
   [junit4]   2> 13643 INFO  (qtp1763107271-64) [n:127.0.0.1:53224_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n2] 
o.a.s.u.PeerSync PeerSync: core=balancedProperties_shard2_replica_n2 
url=https://127.0.0.1:53224/solr DONE.  We have no versions.  sync failed.
   [junit4]   2> 13662 INFO  (qtp741489790-55) [n:127.0.0.1:55091_solr 
c:balancedProperties s:shard2 r:core_node2 
x:balancedProperties_shard2_replica_n1] o.a.s.c.S.Request 
[balancedProperties_shard2_replica_n1]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=4
   [junit4]   2> 13668 INFO  (qtp1763107271-64) [n:127.0.0.1:53224_solr 
c:balancedProperties s:shard2  x:balancedProperties_shard2_replica_n2] 
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the 
next candidat

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

xec.execute(MainClientExec.java:236)
   [junit4]   2>        at 
org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:184)
   [junit4]   2>        at 
org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:88)
   [junit4]   2>        at 
org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
   [junit4]   2>        at 
org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:184)
   [junit4]   2>        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
   [junit4]   2>        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
   [junit4]   2>        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:498)
   [junit4]   2>        ... 9 more
   [junit4]   2> Caused by: java.net.ConnectException: Connection refused 
(Connection refused)
   [junit4]   2>        at java.net.PlainSocketImpl.socketConnect(Native Method)
   [junit4]   2>        at 
java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:350)
   [junit4]   2>        at 
java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206)
   [junit4]   2>        at 
java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188)
   [junit4]   2>        at 
java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)
   [junit4]   2>        at java.net.Socket.connect(Socket.java:589)
   [junit4]   2>        at 
org.apache.http.conn.socket.PlainConnectionSocketFactory.connectSocket(PlainConnectionSocketFactory.java:74)
   [junit4]   2>        at 
org.apache.http.impl.conn.DefaultHttpClientConnectionOperator.connect(DefaultHttpClientConnectionOperator.java:134)
   [junit4]   2>        ... 19 more
   [junit4]   2> 
   [junit4]   2> 3130626 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[B693392A06F62FF5])
 [    ] o.e.j.s.AbstractConnector Stopped 
ServerConnector@4394bb3c{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 3130626 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[B693392A06F62FF5])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=628667740
   [junit4]   2> 3130626 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[B693392A06F62FF5])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.node, tag=null
   [junit4]   2> 3130628 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[B693392A06F62FF5])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jvm, tag=null
   [junit4]   2> 3130630 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[B693392A06F62FF5])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jetty, tag=null
   [junit4]   2> 3130630 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[B693392A06F62FF5])
 [    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 3130631 INFO  (coreCloseExecutor-12557-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@66218a49
   [junit4]   2> 3130634 INFO  (coreCloseExecutor-12557-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=1713474121
   [junit4]   2> 3130638 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[B693392A06F62FF5])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@530dff68{/solr,null,UNAVAILABLE}
   [junit4]   2> 3130639 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[B693392A06F62FF5])
 [    ] o.e.j.s.AbstractConnector Stopped 
ServerConnector@5d5cc252{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 3130639 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[B693392A06F62FF5])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=476143070
   [junit4]   2> 3130640 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[B693392A06F62FF5])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.node, tag=null
   [junit4]   2> 3130640 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[B693392A06F62FF5])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jvm, tag=null
   [junit4]   2> 3130640 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[B693392A06F62FF5])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.jetty, tag=null
   [junit4]   2> 3130640 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[B693392A06F62FF5])
 [    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 3130640 INFO  (coreCloseExecutor-12559-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1210b05d
   [junit4]   2> 3130641 INFO  (coreCloseExecutor-12559-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=303083613
   [junit4]   2> 3130642 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[B693392A06F62FF5])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@772c6632{/solr,null,UNAVAILABLE}
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_B693392A06F62FF5-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{name=Lucene50(blocksize=128), id=Lucene50(blocksize=128), 
newname=Lucene50(blocksize=128)}, docValues:{}, maxPointsInLeafNode=732, 
maxMBSortInHeap=7.485847824316912, sim=RandomSimilarity(queryNorm=true): {}, 
locale=en-CA, timezone=MST
   [junit4]   2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation 
1.8.0_131 (64-bit)/cpus=4,threads=1,free=151318544,total=525860864
   [junit4]   2> NOTE: All tests run in this JVM: [CdcrBootstrapTest, 
FileBasedSpellCheckerTest, TestCopyFieldCollectionResource, 
TestSolrFieldCacheBean, BigEndianAscendingWordDeserializerTest, 
TestNumericTerms64, TemplateUpdateProcessorTest, TestIntervalFaceting, 
RollingRestartTest, TestSSLRandomization, FacetPivotSmallTest, 
TestFieldCacheSort, TestSchemaSimilarityResource, HdfsRecoverLeaseTest, 
ClassificationUpdateProcessorFactoryTest, MultiTermTest, 
OverriddenZkACLAndCredentialsProvidersTest, HdfsUnloadDistributedZkTest, 
PeerSyncWithIndexFingerprintCachingTest, TestFaceting, PreAnalyzedFieldTest, 
TestConfigSetsAPIZkFailure, TestSolrConfigHandler, EnumFieldTest, 
AnalysisAfterCoreReloadTest, TestDistribDocBasedVersion, CacheHeaderTest, 
HdfsSyncSliceTest, TestStressLucene, PathHierarchyTokenizerFactoryTest, 
SecurityConfHandlerTest, DisMaxRequestHandlerTest, CoreAdminCreateDiscoverTest, 
TestTolerantUpdateProcessorRandomCloud, CollectionTooManyReplicasTest, 
TestRestManager, TestSmileRequest, UUIDUpdateProcessorFallbackTest, 
HdfsBasicDistributedZk2Test, TestDistributedSearch, TestClusterStateMutator, 
HttpPartitionTest, TestFieldSortValues, TestStressLiveNodes, 
TestSolrCoreProperties, TestCloudInspectUtil, TestPseudoReturnFields, 
TestReplicaProperties, URLClassifyProcessorTest, ConnectionReuseTest, 
ResponseLogComponentTest, DistributedFacetPivotSmallAdvancedTest, 
UniqFieldsUpdateProcessorFactoryTest, TestAtomicUpdateErrorCases, 
RegexBoostProcessorTest, TestRandomFaceting, ParsingFieldUpdateProcessorsTest, 
TestChildDocTransformer, TestFieldCacheWithThreads, 
XsltUpdateRequestHandlerTest, VMParamsZkACLAndCredentialsProvidersTest, 
StandardRequestHandlerTest, CopyFieldTest, TestCrossCoreJoin, ReplaceNodeTest, 
TestReqParamsAPI, TestCodecSupport, TestHdfsCloudBackupRestore, 
TestSolrCloudWithHadoopAuthPlugin, TestReloadDeadlock, SpatialRPTFieldTypeTest, 
TestFunctionQuery, DateMathParserTest, TestOnReconnectListenerSupport, 
TimeZoneUtilsTest, TestLMJelinekMercerSimilarityFactory, TestReplicationHandler]
   [junit4] Completed [450/725 (3!)] on J0 in 617.82s, 16 tests, 1 failure, 1 
skipped <<< FAILURES!

[...truncated 6168 lines...]
   [junit4] Suite: org.apache.solr.handler.extraction.TestExtractionDateUtil
   [junit4]   2> NOTE: download the large Jenkins line-docs file by running 
'ant get-jenkins-line-docs' in the lucene directory.
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestExtractionDateUtil -Dtests.method=testParseDate 
-Dtests.seed=1405E46F66B64616 -Dtests.multiplier=2 -Dtests.nightly=true 
-Dtests.slow=true 
-Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/test-data/enwiki.random.lines.txt
 -Dtests.locale=mk-MK -Dtests.timezone=America/Metlakatla -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] FAILURE 0.05s J1 | TestExtractionDateUtil.testParseDate <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: Incorrect parsed 
timestamp: 1226583351000 != 1226579751000 (Thu Nov 13 04:35:51 AKST 2008)
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([1405E46F66B64616:5E1C9C5A1D1F31A3]:0)
   [junit4]    >        at 
org.apache.solr.handler.extraction.TestExtractionDateUtil.assertParsedDate(TestExtractionDateUtil.java:59)
   [junit4]    >        at 
org.apache.solr.handler.extraction.TestExtractionDateUtil.testParseDate(TestExtractionDateUtil.java:54)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, 
docValues:{}, maxPointsInLeafNode=1846, maxMBSortInHeap=5.002113897958544, 
sim=RandomSimilarity(queryNorm=true): {}, locale=mk-MK, 
timezone=America/Metlakatla
   [junit4]   2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation 
1.8.0_131 (64-bit)/cpus=4,threads=1,free=200049424,total=253231104
   [junit4]   2> NOTE: All tests run in this JVM: [TestExtractionDateUtil]
   [junit4] Completed [1/4 (1!)] on J1 in 1.46s, 2 tests, 1 failure <<< 
FAILURES!

[...truncated 38100 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to