Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-trunk/923/
2 tests failed.
FAILED:
org.apache.solr.handler.TestReplicationHandler.doTestReplicateAfterCoreReload
Error Message:
expected:<[{indexVersion=1454523269151,generation=2,filelist=[_ec7.cfe,
_ec7.cfs, _ec7.si, _ed9.cfe, _ed9.cfs, _ed9.si, _eda.cfe, _eda.cfs, _eda.si,
_edb.cfe, _edb.cfs, _edb.si, _edc.cfe, _edc.cfs, _edc.si, _edd.cfe, _edd.cfs,
_edd.si, _ede.cfe, _ede.cfs, _ede.si, _edf.cfe, _edf.cfs, _edf.si, _edg.cfe,
_edg.cfs, _edg.si, _edh.cfe, _edh.cfs, _edh.si, _edi.cfe, _edi.cfs, _edi.si,
_edj.cfe, _edj.cfs, _edj.si, _edk.cfe, _edk.cfs, _edk.si, _edl.cfe, _edl.cfs,
_edl.si, _edm.cfe, _edm.cfs, _edm.si, _edn.cfe, _edn.cfs, _edn.si, _edo.cfe,
_edo.cfs, _edo.si, _edp.cfe, _edp.cfs, _edp.si, _edq.cfe, _edq.cfs, _edq.si,
_edr.cfe, _edr.cfs, _edr.si, _eds.cfe, _eds.cfs, _eds.si, _edt.cfe, _edt.cfs,
_edt.si, _edu.cfe, _edu.cfs, _edu.si, _edv.cfe, _edv.cfs, _edv.si, _edw.cfe,
_edw.cfs, _edw.si, _edx.cfe, _edx.cfs, _edx.si, _edy.cfe, _edy.cfs, _edy.si,
_edz.cfe, _edz.cfs, _edz.si, _ee0.cfe, _ee0.cfs, _ee0.si, _ee1.cfe, _ee1.cfs,
_ee1.si, _ee2.cfe, _ee2.cfs, _ee2.si, _ee3.cfe, _ee3.cfs, _ee3.si, _ee4.cfe,
_ee4.cfs, _ee4.si, _ee5.cfe, _ee5.cfs, _ee5.si, _ee6.cfe, _ee6.cfs, _ee6.si,
_ee7.cfe, _ee7.cfs, _ee7.si, _ee8.cfe, _ee8.cfs, _ee8.si, _ee9.cfe, _ee9.cfs,
_ee9.si, _eea.cfe, _eea.cfs, _eea.si, _eec.cfe, _eec.cfs, _eec.si, _eed.cfe,
_eed.cfs, _eed.si, _eee.cfe, _eee.cfs, _eee.si, _eef.cfe, _eef.cfs, _eef.si,
_eeg.cfe, _eeg.cfs, _eeg.si, _eeh.cfe, _eeh.cfs, _eeh.si, _eei.cfe, _eei.cfs,
_eei.si, _eej.cfe, _eej.cfs, _eej.si, _eek.cfe, _eek.cfs, _eek.si, _eel.cfe,
_eel.cfs, _eel.si, _eem.cfe, _eem.cfs, _eem.si, _een.cfe, _een.cfs, _een.si,
_eeo.cfe, _eeo.cfs, _eeo.si, segments_2]}]> but
was:<[{indexVersion=1454523269151,generation=2,filelist=[_ec7.cfe, _ec7.cfs,
_ec7.si, _ed9.cfe, _ed9.cfs, _ed9.si, _eda.cfe, _eda.cfs, _eda.si, _edb.cfe,
_edb.cfs, _edb.si, _edc.cfe, _edc.cfs, _edc.si, _edd.cfe, _edd.cfs, _edd.si,
_ede.cfe, _ede.cfs, _ede.si, _edf.cfe, _edf.cfs, _edf.si, _edg.cfe, _edg.cfs,
_edg.si, _edh.cfe, _edh.cfs, _edh.si, _edi.cfe, _edi.cfs, _edi.si, _edj.cfe,
_edj.cfs, _edj.si, _edk.cfe, _edk.cfs, _edk.si, _edl.cfe, _edl.cfs, _edl.si,
_edm.cfe, _edm.cfs, _edm.si, _edn.cfe, _edn.cfs, _edn.si, _edo.cfe, _edo.cfs,
_edo.si, _edp.cfe, _edp.cfs, _edp.si, _edq.cfe, _edq.cfs, _edq.si, _edr.cfe,
_edr.cfs, _edr.si, _eds.cfe, _eds.cfs, _eds.si, _edt.cfe, _edt.cfs, _edt.si,
_edu.cfe, _edu.cfs, _edu.si, _edv.cfe, _edv.cfs, _edv.si, _edw.cfe, _edw.cfs,
_edw.si, _edx.cfe, _edx.cfs, _edx.si, _edy.cfe, _edy.cfs, _edy.si, _edz.cfe,
_edz.cfs, _edz.si, _ee0.cfe, _ee0.cfs, _ee0.si, _ee1.cfe, _ee1.cfs, _ee1.si,
_ee2.cfe, _ee2.cfs, _ee2.si, _ee3.cfe, _ee3.cfs, _ee3.si, _ee4.cfe, _ee4.cfs,
_ee4.si, _ee5.cfe, _ee5.cfs, _ee5.si, _ee6.cfe, _ee6.cfs, _ee6.si, _ee7.cfe,
_ee7.cfs, _ee7.si, _ee8.cfe, _ee8.cfs, _ee8.si, _ee9.cfe, _ee9.cfs, _ee9.si,
_eea.cfe, _eea.cfs, _eea.si, _eec.cfe, _eec.cfs, _eec.si, _eed.cfe, _eed.cfs,
_eed.si, _eee.cfe, _eee.cfs, _eee.si, _eef.cfe, _eef.cfs, _eef.si, _eeg.cfe,
_eeg.cfs, _eeg.si, _eeh.cfe, _eeh.cfs, _eeh.si, _eei.cfe, _eei.cfs, _eei.si,
_eej.cfe, _eej.cfs, _eej.si, _eek.cfe, _eek.cfs, _eek.si, _eel.cfe, _eel.cfs,
_eel.si, _eem.cfe, _eem.cfs, _eem.si, _een.cfe, _een.cfs, _een.si, _eeo.cfe,
_eeo.cfs, _eeo.si, segments_2]},
{indexVersion=1454523269151,generation=3,filelist=[_eea.cfe, _eea.cfs, _eea.si,
_eeb.cfe, _eeb.cfs, _eeb.si, _eec.cfe, _eec.cfs, _eec.si, _eed.cfe, _eed.cfs,
_eed.si, _eee.cfe, _eee.cfs, _eee.si, _eef.cfe, _eef.cfs, _eef.si, _eeg.cfe,
_eeg.cfs, _eeg.si, _eeh.cfe, _eeh.cfs, _eeh.si, _eei.cfe, _eei.cfs, _eei.si,
_eej.cfe, _eej.cfs, _eej.si, _eek.cfe, _eek.cfs, _eek.si, _eel.cfe, _eel.cfs,
_eel.si, _eem.cfe, _eem.cfs, _eem.si, _een.cfe, _een.cfs, _een.si, _eeo.cfe,
_eeo.cfs, _eeo.si, segments_3]}]>
Stack Trace:
java.lang.AssertionError:
expected:<[{indexVersion=1454523269151,generation=2,filelist=[_ec7.cfe,
_ec7.cfs, _ec7.si, _ed9.cfe, _ed9.cfs, _ed9.si, _eda.cfe, _eda.cfs, _eda.si,
_edb.cfe, _edb.cfs, _edb.si, _edc.cfe, _edc.cfs, _edc.si, _edd.cfe, _edd.cfs,
_edd.si, _ede.cfe, _ede.cfs, _ede.si, _edf.cfe, _edf.cfs, _edf.si, _edg.cfe,
_edg.cfs, _edg.si, _edh.cfe, _edh.cfs, _edh.si, _edi.cfe, _edi.cfs, _edi.si,
_edj.cfe, _edj.cfs, _edj.si, _edk.cfe, _edk.cfs, _edk.si, _edl.cfe, _edl.cfs,
_edl.si, _edm.cfe, _edm.cfs, _edm.si, _edn.cfe, _edn.cfs, _edn.si, _edo.cfe,
_edo.cfs, _edo.si, _edp.cfe, _edp.cfs, _edp.si, _edq.cfe, _edq.cfs, _edq.si,
_edr.cfe, _edr.cfs, _edr.si, _eds.cfe, _eds.cfs, _eds.si, _edt.cfe, _edt.cfs,
_edt.si, _edu.cfe, _edu.cfs, _edu.si, _edv.cfe, _edv.cfs, _edv.si, _edw.cfe,
_edw.cfs, _edw.si, _edx.cfe, _edx.cfs, _edx.si, _edy.cfe, _edy.cfs, _edy.si,
_edz.cfe, _edz.cfs, _edz.si, _ee0.cfe, _ee0.cfs, _ee0.si, _ee1.cfe, _ee1.cfs,
_ee1.si, _ee2.cfe, _ee2.cfs, _ee2.si, _ee3.cfe, _ee3.cfs, _ee3.si, _ee4.cfe,
_ee4.cfs, _ee4.si, _ee5.cfe, _ee5.cfs, _ee5.si, _ee6.cfe, _ee6.cfs, _ee6.si,
_ee7.cfe, _ee7.cfs, _ee7.si, _ee8.cfe, _ee8.cfs, _ee8.si, _ee9.cfe, _ee9.cfs,
_ee9.si, _eea.cfe, _eea.cfs, _eea.si, _eec.cfe, _eec.cfs, _eec.si, _eed.cfe,
_eed.cfs, _eed.si, _eee.cfe, _eee.cfs, _eee.si, _eef.cfe, _eef.cfs, _eef.si,
_eeg.cfe, _eeg.cfs, _eeg.si, _eeh.cfe, _eeh.cfs, _eeh.si, _eei.cfe, _eei.cfs,
_eei.si, _eej.cfe, _eej.cfs, _eej.si, _eek.cfe, _eek.cfs, _eek.si, _eel.cfe,
_eel.cfs, _eel.si, _eem.cfe, _eem.cfs, _eem.si, _een.cfe, _een.cfs, _een.si,
_eeo.cfe, _eeo.cfs, _eeo.si, segments_2]}]> but
was:<[{indexVersion=1454523269151,generation=2,filelist=[_ec7.cfe, _ec7.cfs,
_ec7.si, _ed9.cfe, _ed9.cfs, _ed9.si, _eda.cfe, _eda.cfs, _eda.si, _edb.cfe,
_edb.cfs, _edb.si, _edc.cfe, _edc.cfs, _edc.si, _edd.cfe, _edd.cfs, _edd.si,
_ede.cfe, _ede.cfs, _ede.si, _edf.cfe, _edf.cfs, _edf.si, _edg.cfe, _edg.cfs,
_edg.si, _edh.cfe, _edh.cfs, _edh.si, _edi.cfe, _edi.cfs, _edi.si, _edj.cfe,
_edj.cfs, _edj.si, _edk.cfe, _edk.cfs, _edk.si, _edl.cfe, _edl.cfs, _edl.si,
_edm.cfe, _edm.cfs, _edm.si, _edn.cfe, _edn.cfs, _edn.si, _edo.cfe, _edo.cfs,
_edo.si, _edp.cfe, _edp.cfs, _edp.si, _edq.cfe, _edq.cfs, _edq.si, _edr.cfe,
_edr.cfs, _edr.si, _eds.cfe, _eds.cfs, _eds.si, _edt.cfe, _edt.cfs, _edt.si,
_edu.cfe, _edu.cfs, _edu.si, _edv.cfe, _edv.cfs, _edv.si, _edw.cfe, _edw.cfs,
_edw.si, _edx.cfe, _edx.cfs, _edx.si, _edy.cfe, _edy.cfs, _edy.si, _edz.cfe,
_edz.cfs, _edz.si, _ee0.cfe, _ee0.cfs, _ee0.si, _ee1.cfe, _ee1.cfs, _ee1.si,
_ee2.cfe, _ee2.cfs, _ee2.si, _ee3.cfe, _ee3.cfs, _ee3.si, _ee4.cfe, _ee4.cfs,
_ee4.si, _ee5.cfe, _ee5.cfs, _ee5.si, _ee6.cfe, _ee6.cfs, _ee6.si, _ee7.cfe,
_ee7.cfs, _ee7.si, _ee8.cfe, _ee8.cfs, _ee8.si, _ee9.cfe, _ee9.cfs, _ee9.si,
_eea.cfe, _eea.cfs, _eea.si, _eec.cfe, _eec.cfs, _eec.si, _eed.cfe, _eed.cfs,
_eed.si, _eee.cfe, _eee.cfs, _eee.si, _eef.cfe, _eef.cfs, _eef.si, _eeg.cfe,
_eeg.cfs, _eeg.si, _eeh.cfe, _eeh.cfs, _eeh.si, _eei.cfe, _eei.cfs, _eei.si,
_eej.cfe, _eej.cfs, _eej.si, _eek.cfe, _eek.cfs, _eek.si, _eel.cfe, _eel.cfs,
_eel.si, _eem.cfe, _eem.cfs, _eem.si, _een.cfe, _een.cfs, _een.si, _eeo.cfe,
_eeo.cfs, _eeo.si, segments_2]},
{indexVersion=1454523269151,generation=3,filelist=[_eea.cfe, _eea.cfs, _eea.si,
_eeb.cfe, _eeb.cfs, _eeb.si, _eec.cfe, _eec.cfs, _eec.si, _eed.cfe, _eed.cfs,
_eed.si, _eee.cfe, _eee.cfs, _eee.si, _eef.cfe, _eef.cfs, _eef.si, _eeg.cfe,
_eeg.cfs, _eeg.si, _eeh.cfe, _eeh.cfs, _eeh.si, _eei.cfe, _eei.cfs, _eei.si,
_eej.cfe, _eej.cfs, _eej.si, _eek.cfe, _eek.cfs, _eek.si, _eel.cfe, _eel.cfs,
_eel.si, _eem.cfe, _eem.cfs, _eem.si, _een.cfe, _een.cfs, _een.si, _eeo.cfe,
_eeo.cfs, _eeo.si, segments_3]}]>
at
__randomizedtesting.SeedInfo.seed([759A047477622D74:504D1F44072A2377]: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:1140)
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:497)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
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:46)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
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:54)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
FAILED: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test
Error Message:
Captured an uncaught exception in thread: Thread[id=5698, name=collection5,
state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught
exception in thread: Thread[id=5698, name=collection5, state=RUNNABLE,
group=TGRP-CollectionsAPIDistributedZkTest]
Caused by: java.lang.RuntimeException:
org.apache.solr.client.solrj.SolrServerException: No live SolrServers available
to handle this request:[http://127.0.0.1:35952/ag_xou,
http://127.0.0.1:49017/ag_xou, http://127.0.0.1:49145/ag_xou,
http://127.0.0.1:34165/ag_xou, http://127.0.0.1:58172/ag_xou]
at __randomizedtesting.SeedInfo.seed([759A047477622D74]:0)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:897)
Caused by: org.apache.solr.client.solrj.SolrServerException: No live
SolrServers available to handle this request:[http://127.0.0.1:35952/ag_xou,
http://127.0.0.1:49017/ag_xou, http://127.0.0.1:49145/ag_xou,
http://127.0.0.1:34165/ag_xou, http://127.0.0.1:58172/ag_xou]
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:352)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1100)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:871)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:807)
at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1593)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1614)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:887)
Caused by:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error
from server at http://127.0.0.1:58172/ag_xou: KeeperErrorCode = Session expired
for /overseer/collection-queue-work/qnr-
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:576)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:240)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:229)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
... 7 more
Build Log:
[...truncated 10879 lines...]
[junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/init-core-data-001
[junit4] 2> 246847 INFO
(SUITE-CollectionsAPIDistributedZkTest-seed#[759A047477622D74]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
[junit4] 2> 246848 INFO
(SUITE-CollectionsAPIDistributedZkTest-seed#[759A047477622D74]-worker) [ ]
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property:
/ag_xou/
[junit4] 2> 246860 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 246861 INFO (Thread-4240) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 246861 INFO (Thread-4240) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 246962 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.ZkTestServer start zk server on port:40232
[junit4] 2> 246962 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 246988 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 247025 INFO (zkCallback-251-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@27c518 name:ZooKeeperConnection
Watcher:127.0.0.1:40232 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 247025 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 247025 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 247025 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 247038 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 247058 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 247079 INFO (zkCallback-252-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@4ea1a72c
name:ZooKeeperConnection Watcher:127.0.0.1:40232/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 247079 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 247079 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 247079 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/collection1
[junit4] 2> 247094 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
[junit4] 2> 247095 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
[junit4] 2> 247111 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
[junit4] 2> 247112 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 247113 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
[junit4] 2> 247114 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 247115 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
[junit4] 2> 247116 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 247116 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 247117 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 247117 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
[junit4] 2> 247123 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 247124 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
[junit4] 2> 247127 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 247128 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
[junit4] 2> 247129 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 247129 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
[junit4] 2> 247130 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 247130 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
[junit4] 2> 247131 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 247131 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 247132 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 247133 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
[junit4] 2> 247137 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 247137 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
[junit4] 2> 247148 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 247172 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 247198 INFO (zkCallback-253-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@787bc721
name:ZooKeeperConnection Watcher:127.0.0.1:40232 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 247198 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 247199 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 247199 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 247201 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 247245 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 247260 INFO (zkCallback-254-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@6195d1d8
name:ZooKeeperConnection Watcher:127.0.0.1:40232/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 247260 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 247260 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 247261 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf2/solrconfig.xml
[junit4] 2> 247261 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/solrconfig.xml
[junit4] 2> 247268 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf2/schema.xml
[junit4] 2> 247269 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/schema.xml
[junit4] 2> 247270 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf2/enumsConfig.xml
[junit4] 2> 247270 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/enumsConfig.xml
[junit4] 2> 247271 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf2/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 247271 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath:
/configs/conf2/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 247273 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf2/stopwords.txt
[junit4] 2> 247273 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/stopwords.txt
[junit4] 2> 247274 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf2/protwords.txt
[junit4] 2> 247274 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/protwords.txt
[junit4] 2> 247276 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf2/currency.xml
[junit4] 2> 247276 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/currency.xml
[junit4] 2> 247277 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf2/open-exchange-rates.json
[junit4] 2> 247277 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/open-exchange-rates.json
[junit4] 2> 247278 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf2/mapping-ISOLatin1Accent.txt
[junit4] 2> 247278 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/mapping-ISOLatin1Accent.txt
[junit4] 2> 247279 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf2/old_synonyms.txt
[junit4] 2> 247279 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/old_synonyms.txt
[junit4] 2> 247281 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf2/synonyms.txt
[junit4] 2> 247281 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/synonyms.txt
[junit4] 2> 247282 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/elevate.xml
to /configs/conf2/elevate.xml
[junit4] 2> 247282 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/elevate.xml
[junit4] 2> 247510 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/control-001/cores/collection1
[junit4] 2> 247512 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.e.j.s.Server jetty-9.2.13.v20150730
[junit4] 2> 247525 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@6db2937a{/ag_xou,null,AVAILABLE}
[junit4] 2> 247526 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@1481fbb2{HTTP/1.1}{127.0.0.1:58172}
[junit4] 2> 247526 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.e.j.s.Server Started @251243ms
[junit4] 2> 247526 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/tempDir-001/control/data,
hostContext=/ag_xou, hostPort=58172,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/control-001/cores}
[junit4] 2> 247526 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@4e0e2f2a
[junit4] 2> 247526 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/control-001'
[junit4] 2> 247526 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 247526 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 247527 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 247527 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 247531 INFO (zkCallback-255-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@31ce77af
name:ZooKeeperConnection Watcher:127.0.0.1:40232/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 247531 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 247531 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 247546 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 247546 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/control-001/solr.xml
[junit4] 2> 247561 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.CorePropertiesLocator Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/control-001/cores
[junit4] 2> 247563 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.CoreContainer New CoreContainer 127530046
[junit4] 2> 247563 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/control-001]
[junit4] 2> 247563 WARN
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.CoreContainer Couldn't add files from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/control-001/lib
to classpath:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/control-001/lib
[junit4] 2> 247564 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme
: ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections :
10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime :
5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
[junit4] 2> 247565 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 247566 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 247566 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 247566 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40232/solr
[junit4] 2> 247566 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 247566 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 247587 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 247599 INFO (zkCallback-258-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@42ec13f3
name:ZooKeeperConnection Watcher:127.0.0.1:40232 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 247599 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 247600 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 247602 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.c.ConnectionManager Waiting for client
to connect to ZooKeeper
[junit4] 2> 247607 INFO
(zkCallback-259-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@3b7ed9d1
name:ZooKeeperConnection Watcher:127.0.0.1:40232/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 247607 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 247608 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 247610 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-queue-work
[junit4] 2> 247613 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-running
[junit4] 2> 247615 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-completed
[junit4] 2> 247616 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-failure
[junit4] 2> 247617 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 247624 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 247625 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.c.SolrZkClient makePath:
/clusterstate.json
[junit4] 2> 247626 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 247627 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:58172_ag_xou
[junit4] 2> 247627 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.c.SolrZkClient makePath:
/live_nodes/127.0.0.1:58172_ag_xou
[junit4] 2> 247628 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 247629 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/election
[junit4] 2> 247630 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 247631 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.LeaderElector Joined leadership election
with path:
/overseer_elect/election/95323510980608006-127.0.0.1:58172_ag_xou-n_0000000000
[junit4] 2> 247631 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:58172_ag_xou
[junit4] 2> 247631 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/leader
[junit4] 2> 247632 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.Overseer Overseer
(id=95323510980608006-127.0.0.1:58172_ag_xou-n_0000000000) starting
[junit4] 2> 247633 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.c.SolrZkClient makePath:
/overseer/queue-work
[junit4] 2> 247638 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.OverseerAutoReplicaFailoverThread
Starting OverseerAutoReplicaFailoverThread
autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=10000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 247639 INFO
(OverseerStateUpdate-95323510980608006-127.0.0.1:58172_ag_xou-n_0000000000)
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.Overseer Starting to work on the main
queue
[junit4] 2> 247639 INFO
(OverseerStateUpdate-95323510980608006-127.0.0.1:58172_ag_xou-n_0000000000)
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.c.ZkStateReader Updating cluster state
from ZooKeeper...
[junit4] 2> 247643 INFO
(OverseerCollectionConfigSetProcessor-95323510980608006-127.0.0.1:58172_ag_xou-n_0000000000)
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.OverseerTaskProcessor Process current
queue of overseer operations
[junit4] 2> 247654 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.c.ZkStateReader Updating cluster state
from ZooKeeper...
[junit4] 2> 247668 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.CoreContainer Security conf doesn't
exist. Skipping setup for authorization module.
[junit4] 2> 247668 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.CoreContainer No authentication plugin
used.
[junit4] 2> 247683 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.CorePropertiesLocator Looking for core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/control-001/cores
[junit4] 2> 247684 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.CoreDescriptor Created CoreDescriptor:
{name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml,
loadOnStartup=true, configSetProperties=configsetprops.json,
collection=control_collection, coreNodeName=, dataDir=data/, shard=}
[junit4] 2> 247684 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.CorePropertiesLocator Found core
collection1 in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/control-001/cores/collection1
[junit4] 2> 247684 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.CorePropertiesLocator Found 1 core
definitions
[junit4] 2> 247692 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection x:collection1]
o.a.s.c.ZkController publishing state=down
[junit4] 2> 247692 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection x:collection1]
o.a.s.c.ZkController numShards not found on descriptor - reading it from system
property
[junit4] 2> 247697 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.s.SolrDispatchFilter
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1
[junit4] 2> 247697 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74])
[n:127.0.0.1:58172_ag_xou ] o.a.s.s.SolrDispatchFilter
SolrDispatchFilter.init() done
[junit4] 2> 247697 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection x:collection1]
o.a.s.c.ZkController look for our core node name
[junit4] 2> 247698 INFO
(OverseerStateUpdate-95323510980608006-127.0.0.1:58172_ag_xou-n_0000000000)
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:58172/ag_xou";,
[junit4] 2> "node_name":"127.0.0.1:58172_ag_xou",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 247698 INFO
(OverseerStateUpdate-95323510980608006-127.0.0.1:58172_ag_xou-n_0000000000)
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.o.ReplicaMutator Update state
numShards=1 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:58172/ag_xou";,
[junit4] 2> "node_name":"127.0.0.1:58172_ag_xou",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 247698 INFO
(OverseerStateUpdate-95323510980608006-127.0.0.1:58172_ag_xou-n_0000000000)
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.o.ClusterStateMutator building a new
cName: control_collection
[junit4] 2> 247699 INFO
(OverseerStateUpdate-95323510980608006-127.0.0.1:58172_ag_xou-n_0000000000)
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.o.ReplicaMutator Assigning new node to
shard shard=shard1
[junit4] 2> 247701 INFO
(zkCallback-259-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json], has occurred - updating... (live nodes size: [1])
[junit4] 2> 247701 INFO
(zkCallback-259-thread-2-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json], has occurred - updating... (live nodes size: [1])
[junit4] 2> 248698 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection x:collection1]
o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1
[junit4] 2> 248698 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection x:collection1]
o.a.s.c.ZkController Check for collection zkNode:control_collection
[junit4] 2> 248707 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection x:collection1]
o.a.s.c.ZkController Collection zkNode exists
[junit4] 2> 248707 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection x:collection1]
o.a.s.c.c.ZkStateReader Load collection config from:
[/collections/control_collection]
[junit4] 2> 248707 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection x:collection1]
o.a.s.c.c.ZkStateReader path=[/collections/control_collection]
[configName]=[conf1] specified config exists in ZooKeeper
[junit4] 2> 248707 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/control-001/cores/collection1'
[junit4] 2> 248707 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 248707 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 248714 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection x:collection1] o.a.s.c.Config
loaded config solrconfig.xml with version 0
[junit4] 2> 248723 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection x:collection1]
o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 248727 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection x:collection1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 248736 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection x:collection1]
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 248742 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 248902 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with
rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 248908 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection x:collection1]
o.a.s.s.IndexSchema default search field in schema is text
[junit4] 2> 248910 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection x:collection1]
o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 248940 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 248942 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 248944 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 248944 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 248946 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection x:collection1]
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default
properties: Can't find resource 'configsetprops.json' in classpath or
'/configs/conf1',
cwd=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1
[junit4] 2> 248946 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection x:collection1]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
collection control_collection
[junit4] 2> 248946 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 248946 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/control-001/cores/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/control-001/cores/collection1/data/]
[junit4] 2> 248946 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr
mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@67bf7365
[junit4] 2> 248947 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/control-001/cores/collection1/data
[junit4] 2> 248948 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/control-001/cores/collection1/data/index/
[junit4] 2> 248948 WARN
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/control-001/cores/collection1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 248948 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/control-001/cores/collection1/data/index
[junit4] 2> 248948 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=1379827783,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 248949 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits:
num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@44501e4a
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@55d22588),segFN=segments_1,generation=1}
[junit4] 2> 248949 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 248953 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 248953 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 248953 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 248953 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 248954 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 248954 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 248954 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 248954 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 248954 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as
default, creating implicit default
[junit4] 2> 248954 WARN
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler
{type = requestHandler,name = /dump,class = DumpRequestHandler,args =
{defaults={a=A,b=B}}}
[junit4] 2> 248955 INFO
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:58172_ag_xou
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore
Looking for old index directories to cleanup for core collection1 in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/control-001/cores/collection1/data/
[junit4] 2> 248956 WARN
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:58172_ag_xou
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.DirectoryFactory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/control-001/cores/collection1/data/
does not point to a valid data directory; skipping clean-up of old index
directories.
[junit4] 2> 248956 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 248964 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 248965 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 248967 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 248971 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.RequestHandlers Registered paths:
/admin/mbeans,standard,/dump,/update/csv,/sql,/update/json/docs,/admin/luke,/export,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/stream,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
[junit4] 2> 248972 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore Using default statsCache cache:
org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 248972 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 248972 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 248973 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 248973 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 248974 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=16, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 248974 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits:
num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@44501e4a
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@55d22588),segFN=segments_1,generation=1}
[junit4] 2> 248974 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 248974 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@1566e7ea[collection1] main]
[junit4] 2> 248975 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.c.ZkStateReader Load collection config from:
[/collections/control_collection]
[junit4] 2> 248975 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.c.ZkStateReader path=[/collections/control_collection]
[configName]=[conf1] specified config exists in ZooKeeper
[junit4] 2> 248975 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.ManagedResourceStorage Setting up ZooKeeper-based
storage for the RestManager with znodeBase: /configs/conf1
[junit4] 2> 248975 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO
with znodeBase: /configs/conf1
[junit4] 2> 248975 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
[junit4] 2> 248976 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 248976 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.ManagedResourceStorage No data found for znode
/configs/conf1/_rest_managed.json
[junit4] 2> 248976 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.ManagedResourceStorage Loaded null at path
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 248976 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 248976 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 248976 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed
version buckets
[junit4] 2> 248977 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for
65536 version buckets from index
[junit4] 2> 248977 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed
version bucket highest value from index
[junit4] 2> 248977 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1525176177895931904
[junit4] 2> 248987 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.UpdateLog Took 10.0ms to seed version buckets with
highest version 1525176177895931904
[junit4] 2> 248994 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1
[junit4] 2> 248995 INFO
(coreLoadExecutor-540-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 248998 INFO
(searcherExecutor-541-thread-1-processing-n:127.0.0.1:58172_ag_xou
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:58172_ag_xou c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@1566e7ea[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 248998 INFO
(coreZkRegister-534-thread-1-processing-n:127.0.0.1:58172_ag_xou x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58172_ag_xou
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
Register replica - core:collection1 address:http://127.0.0.1:58172/ag_xou
collection:control_collection shard:shard1
[junit4] 2> 248999 INFO
(coreZkRegister-534-thread-1-processing-n:127.0.0.1:58172_ag_xou x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58172_ag_xou
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.c.SolrZkClient makePath:
/collections/control_collection/leader_elect/shard1/election
[junit4] 2> 249003 INFO
(coreZkRegister-534-thread-1-processing-n:127.0.0.1:58172_ag_xou x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58172_ag_xou
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.LeaderElector
Joined leadership election with path:
/collections/control_collection/leader_elect/shard1/election/95323510980608006-core_node1-n_0000000000
[junit4] 2> 249003 INFO
(coreZkRegister-534-thread-1-processing-n:127.0.0.1:58172_ag_xou x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58172_ag_xou
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext Running the leader process for shard=shard1
and weAreReplacement=false and leaderVoteWait=180000
[junit4] 2> 249005 INFO
(coreZkRegister-534-thread-1-processing-n:127.0.0.1:58172_ag_xou x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58172_ag_xou
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 249005 INFO
(coreZkRegister-534-thread-1-processing-n:127.0.0.1:58172_ag_xou x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58172_ag_xou
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 249005 INFO
(coreZkRegister-534-thread-1-processing-n:127.0.0.1:58172_ag_xou x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58172_ag_xou
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
Sync replicas to http://127.0.0.1:58172/ag_xou/collection1/
[junit4] 2> 249005 INFO
(coreZkRegister-534-thread-1-processing-n:127.0.0.1:58172_ag_xou x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58172_ag_xou
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 249005 INFO
(coreZkRegister-534-thread-1-processing-n:127.0.0.1:58172_ag_xou x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58172_ag_xou
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
http://127.0.0.1:58172/ag_xou/collection1/ has no replicas
[junit4] 2> 249005 INFO
(OverseerStateUpdate-95323510980608006-127.0.0.1:58172_ag_xou-n_0000000000)
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection"} current state version: 1
[junit4] 2> 249006 INFO
(coreZkRegister-534-thread-1-processing-n:127.0.0.1:58172_ag_xou x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58172_ag_xou
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1
[junit4] 2> 249008 INFO
(coreZkRegister-534-thread-1-processing-n:127.0.0.1:58172_ag_xou x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58172_ag_xou
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
[junit4] 2> 249022 INFO
(OverseerStateUpdate-95323510980608006-127.0.0.1:58172_ag_xou-n_0000000000)
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "base_url":"http://127.0.0.1:58172/ag_xou";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 1
[junit4] 2> 249023 INFO
(coreZkRegister-534-thread-1-processing-n:127.0.0.1:58172_ag_xou x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58172_ag_xou
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:58172/ag_xou/collection1/ shard1
[junit4] 2> 249125 INFO
(zkCallback-259-thread-2-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json], has occurred - updating... (live nodes size: [1])
[junit4] 2> 249125 INFO
(zkCallback-259-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json], has occurred - updating... (live nodes size: [1])
[junit4] 2> 249127 INFO
(coreZkRegister-534-thread-1-processing-n:127.0.0.1:58172_ag_xou x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58172_ag_xou
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
We are http://127.0.0.1:58172/ag_xou/collection1/ and leader is
http://127.0.0.1:58172/ag_xou/collection1/
[junit4] 2> 249127 INFO
(coreZkRegister-534-thread-1-processing-n:127.0.0.1:58172_ag_xou x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58172_ag_xou
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:58172/ag_xou
[junit4] 2> 249127 INFO
(coreZkRegister-534-thread-1-processing-n:127.0.0.1:58172_ag_xou x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58172_ag_xou
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
I am the leader, no recovery necessary
[junit4] 2> 249127 INFO
(coreZkRegister-534-thread-1-processing-n:127.0.0.1:58172_ag_xou x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58172_ag_xou
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
publishing state=active
[junit4] 2> 249127 INFO
(coreZkRegister-534-thread-1-processing-n:127.0.0.1:58172_ag_xou x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58172_ag_xou
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
numShards not found on descriptor - reading it from system property
[junit4] 2> 249130 INFO
(OverseerStateUpdate-95323510980608006-127.0.0.1:58172_ag_xou-n_0000000000)
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:58172/ag_xou";,
[junit4] 2> "node_name":"127.0.0.1:58172_ag_xou",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"} current state version: 2
[junit4] 2> 249130 INFO
(OverseerStateUpdate-95323510980608006-127.0.0.1:58172_ag_xou-n_0000000000)
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.o.ReplicaMutator Update state
numShards=1 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:58172/ag_xou";,
[junit4] 2> "node_name":"127.0.0.1:58172_ag_xou",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 249199 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 249210 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 249232 INFO
(zkCallback-259-thread-2-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json], has occurred - updating... (live nodes size: [1])
[junit4] 2> 249233 INFO
(zkCallback-259-thread-1-processing-n:127.0.0.1:58172_ag_xou)
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/clusterstate.json], has occurred - updating... (live nodes size: [1])
[junit4] 2> 249256 INFO (zkCallback-261-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1ec9f99 name:ZooKeeperConnection
Watcher:127.0.0.1:40232/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 249256 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 249256 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 249256 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 249259 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection
loss:false
[junit4] 2> 249259 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with stateFormat=2
[junit4] 2> 249259 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 249260 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 249264 INFO (zkCallback-262-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@59c2cb24
name:ZooKeeperConnection Watcher:127.0.0.1:40232/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 249264 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 249264 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 249277 INFO
(OverseerStateUpdate-95323510980608006-127.0.0.1:58172_ag_xou-n_0000000000)
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "operation":"create",
[junit4] 2> "name":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "stateFormat":"2"} current state version: 3
[junit4] 2> 249277 INFO
(OverseerStateUpdate-95323510980608006-127.0.0.1:58172_ag_xou-n_0000000000)
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.o.ClusterStateMutator building a new
cName: collection1
[junit4] 2> 249379 INFO
(OverseerStateUpdate-95323510980608006-127.0.0.1:58172_ag_xou-n_0000000000)
[n:127.0.0.1:58172_ag_xou ] o.a.s.c.o.ZkStateWriter going to
create_collection /collections/collection1/state.json
[junit4] 2> 249461 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/shard-1-001/cores/collection1
[junit4] 2> 249463 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/shard-1-001
[junit4] 2> 249463 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.e.j.s.Server jetty-9.2.13.v20150730
[junit4] 2> 249486 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@41e7cceb{/ag_xou,null,AVAILABLE}
[junit4] 2> 249487 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@59fb776d{HTTP/1.1}{127.0.0.1:49017}
[junit4] 2> 249487 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.e.j.s.Server Started @253204ms
[junit4] 2> 249487 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/tempDir-001/jetty1,
solrconfig=solrconfig.xml, hostContext=/ag_xou, hostPort=49017,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/shard-1-001/cores}
[junit4] 2> 249487 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@4e0e2f2a
[junit4] 2> 249487 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/shard-1-001'
[junit4] 2> 249488 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 249488 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 249488 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 249505 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 249514 INFO (zkCallback-263-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@6bb71aa3
name:ZooKeeperConnection Watcher:127.0.0.1:40232/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 249515 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 249515 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 249517 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 249517 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/shard-1-001/solr.xml
[junit4] 2> 249522 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.CorePropertiesLocator Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/shard-1-001/cores
[junit4] 2> 249522 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.CoreContainer New CoreContainer 1198852408
[junit4] 2> 249522 INFO
(TEST-CollectionsAPIDistributedZkTest.test-seed#[759A047477622D74]) [ ]
o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_759A047477622D74-001/s
[...truncated too long message...]
7477622D74]) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to
close
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_759A047477622D74-001/solr-instance-027/./collection1/data
[CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_759A047477622D74-001/solr-instance-027/./collection1/data;done=false>>]
[junit4] 2> 2531535 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[759A047477622D74])
[ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_759A047477622D74-001/solr-instance-027/./collection1/data
[junit4] 2> 2531535 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[759A047477622D74])
[ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_759A047477622D74-001/solr-instance-027/./collection1/data/index
[CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_759A047477622D74-001/solr-instance-027/./collection1/data/index;done=false>>]
[junit4] 2> 2531535 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[759A047477622D74])
[ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_759A047477622D74-001/solr-instance-027/./collection1/data/index
[junit4] 2> 2531536 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[759A047477622D74])
[ x:collection1] o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@3e6f203a{/solr,null,UNAVAILABLE}
[junit4] 2> 2531537 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[759A047477622D74])
[ ] o.e.j.s.ServerConnector Stopped
ServerConnector@8606469{HTTP/1.1}{127.0.0.1:0}
[junit4] 2> 2531537 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[759A047477622D74])
[ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=302399055
[junit4] 2> 2531537 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[759A047477622D74])
[ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@5b9b02d1
[junit4] 2> 2531538 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[759A047477622D74])
[ x:collection1] o.a.s.u.DirectUpdateHandler2 closing
DirectUpdateHandler2{commits=5,autocommits=0,soft
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=5,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 2531538 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[759A047477622D74])
[ x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 2531538 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[759A047477622D74])
[ x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has
reached 0 - closing IndexWriter
[junit4] 2> 2531538 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[759A047477622D74])
[ x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with
IndexWriterCloser
[junit4] 2> 2531538 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[759A047477622D74])
[ x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on
request.
[junit4] 2> 2531539 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[759A047477622D74])
[ x:collection1] o.a.s.c.CachingDirectoryFactory Closing
MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 2531539 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[759A047477622D74])
[ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_759A047477622D74-001/solr-instance-028/./collection1/data/index
[CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_759A047477622D74-001/solr-instance-028/./collection1/data/index;done=false>>]
[junit4] 2> 2531539 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[759A047477622D74])
[ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_759A047477622D74-001/solr-instance-028/./collection1/data/index
[junit4] 2> 2531539 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[759A047477622D74])
[ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_759A047477622D74-001/solr-instance-028/./collection1/data
[CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_759A047477622D74-001/solr-instance-028/./collection1/data;done=false>>]
[junit4] 2> 2531539 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[759A047477622D74])
[ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_759A047477622D74-001/solr-instance-028/./collection1/data
[junit4] 2> 2531540 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[759A047477622D74])
[ x:collection1] o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@7b857cb2{/solr,null,UNAVAILABLE}
[junit4] 2> 2531545 INFO
(SUITE-TestReplicationHandler-seed#[759A047477622D74]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_759A047477622D74-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene60):
{name=PostingsFormat(name=LuceneVarGapFixedInterval),
id=PostingsFormat(name=LuceneVarGapFixedInterval),
newname=PostingsFormat(name=LuceneVarGapFixedInterval)}, docValues:{},
sim=RandomSimilarity(queryNorm=false,coord=crazy): {}, locale=lt-LT,
timezone=Asia/Muscat
[junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation
1.8.0_66 (64-bit)/cpus=4,threads=1,free=170876232,total=524812288
[junit4] 2> NOTE: All tests run in this JVM: [SSLMigrationTest,
TestExpandComponent, ExternalFileFieldSortTest, TestNRTOpen,
ParsingFieldUpdateProcessorsTest, SuggestComponentContextFilterQueryTest,
TestRestManager, DistributedDebugComponentTest, ConfigSetsAPITest,
CloudExitableDirectoryReaderTest, PreAnalyzedFieldTest, SortSpecParsingTest,
TestSolr4Spatial, TestClassicSimilarityFactory, DistribJoinFromCollectionTest,
TestMiniSolrCloudClusterSSL, TestConfigSetProperties, SystemInfoHandlerTest,
TestCloudManagedSchemaConcurrent, TestInitQParser,
CloneFieldUpdateProcessorFactoryTest, SolrRequestParserTest, TestCrossCoreJoin,
TestAtomicUpdateErrorCases, TestCryptoKeys, CdcrReplicationDistributedZkTest,
RequestLoggingTest, XsltUpdateRequestHandlerTest, TestSchemaNameResource,
DateRangeFieldTest, CoreAdminCreateDiscoverTest, TestFieldSortValues,
TestPseudoReturnFields, RuleEngineTest, TestReplicaProperties,
AlternateDirectoryTest, TestPerFieldSimilarityClassic, TestExactStatsCache,
TestJoin, TestSimpleQParserPlugin, HdfsRestartWhileUpdatingTest,
LeaderInitiatedRecoveryOnCommitTest, TestRTimerTree, TestStandardQParsers,
TestReplicationHandler]
[junit4] Completed [228/577 (2!)] on J0 in 794.90s, 13 tests, 1 failure <<<
FAILURES!
[...truncated 1108 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:747:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:684:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:59:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build.xml:233:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/common-build.xml:524:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:1457:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:1014:
There were test failures: 577 suites (8 ignored), 2321 tests, 1 error, 1
failure, 33 ignored (18 assumptions) [seed: 759A047477622D74]
Total time: 191 minutes 43 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
No prior successful build to compare, so performing full copy of artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
