Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-trunk/740/
3 tests failed. FAILED: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test Error Message: Captured an uncaught exception in thread: Thread[id=2712, name=collection4, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=2712, name=collection4, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest] Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:49901/jbgv/oy: collection already exists: awholynewstresscollection_collection4_0 at __randomizedtesting.SeedInfo.seed([A108012B41E9020D]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:560) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:234) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:226) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:376) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:328) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1086) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:856) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:799) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220) at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1572) at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1593) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:887) FAILED: org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.test Error Message: Captured an uncaught exception in thread: Thread[id=64964, name=collection4, state=RUNNABLE, group=TGRP-HdfsCollectionsAPIDistributedZkTest] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=64964, name=collection4, state=RUNNABLE, group=TGRP-HdfsCollectionsAPIDistributedZkTest] Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:41345/zqga/v: Could not find collection : awholynewstresscollection_collection4_0 at __randomizedtesting.SeedInfo.seed([A108012B41E9020D]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:560) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:234) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:226) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:376) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:328) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1086) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:856) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:799) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:894) FAILED: org.apache.solr.handler.TestReplicationHandler.doTestReplicateAfterCoreReload Error Message: expected:<[{indexVersion=1436939928071,generation=2,filelist=[_0.fdt, _0.fdx, _0.fnm, _0.nvd, _0.nvm, _0.si, _0_BlockTreeOrds_0.doc, _0_BlockTreeOrds_0.tio, _0_BlockTreeOrds_0.tipo, _4.fdt, _4.fdx, _4.fnm, _4.nvd, _4.nvm, _4.si, _4_BlockTreeOrds_0.doc, _4_BlockTreeOrds_0.tio, _4_BlockTreeOrds_0.tipo, _6.fdt, _6.fdx, _6.fnm, _6.nvd, _6.nvm, _6.si, _6_BlockTreeOrds_0.doc, _6_BlockTreeOrds_0.tio, _6_BlockTreeOrds_0.tipo, _7.fdt, _7.fdx, _7.fnm, _7.nvd, _7.nvm, _7.si, _7_BlockTreeOrds_0.doc, _7_BlockTreeOrds_0.tio, _7_BlockTreeOrds_0.tipo, segments_2]}]> but was:<[{indexVersion=1436939928071,generation=2,filelist=[_0.fdt, _0.fdx, _0.fnm, _0.nvd, _0.nvm, _0.si, _0_BlockTreeOrds_0.doc, _0_BlockTreeOrds_0.tio, _0_BlockTreeOrds_0.tipo, _4.fdt, _4.fdx, _4.fnm, _4.nvd, _4.nvm, _4.si, _4_BlockTreeOrds_0.doc, _4_BlockTreeOrds_0.tio, _4_BlockTreeOrds_0.tipo, _6.fdt, _6.fdx, _6.fnm, _6.nvd, _6.nvm, _6.si, _6_BlockTreeOrds_0.doc, _6_BlockTreeOrds_0.tio, _6_BlockTreeOrds_0.tipo, _7.fdt, _7.fdx, _7.fnm, _7.nvd, _7.nvm, _7.si, _7_BlockTreeOrds_0.doc, _7_BlockTreeOrds_0.tio, _7_BlockTreeOrds_0.tipo, segments_2]}, {indexVersion=1436939928071,generation=3,filelist=[_0.fdt, _0.fdx, _0.fnm, _0.nvd, _0.nvm, _0.si, _0_BlockTreeOrds_0.doc, _0_BlockTreeOrds_0.tio, _0_BlockTreeOrds_0.tipo, _8.cfe, _8.cfs, _8.si, segments_3]}]> Stack Trace: java.lang.AssertionError: expected:<[{indexVersion=1436939928071,generation=2,filelist=[_0.fdt, _0.fdx, _0.fnm, _0.nvd, _0.nvm, _0.si, _0_BlockTreeOrds_0.doc, _0_BlockTreeOrds_0.tio, _0_BlockTreeOrds_0.tipo, _4.fdt, _4.fdx, _4.fnm, _4.nvd, _4.nvm, _4.si, _4_BlockTreeOrds_0.doc, _4_BlockTreeOrds_0.tio, _4_BlockTreeOrds_0.tipo, _6.fdt, _6.fdx, _6.fnm, _6.nvd, _6.nvm, _6.si, _6_BlockTreeOrds_0.doc, _6_BlockTreeOrds_0.tio, _6_BlockTreeOrds_0.tipo, _7.fdt, _7.fdx, _7.fnm, _7.nvd, _7.nvm, _7.si, _7_BlockTreeOrds_0.doc, _7_BlockTreeOrds_0.tio, _7_BlockTreeOrds_0.tipo, segments_2]}]> but was:<[{indexVersion=1436939928071,generation=2,filelist=[_0.fdt, _0.fdx, _0.fnm, _0.nvd, _0.nvm, _0.si, _0_BlockTreeOrds_0.doc, _0_BlockTreeOrds_0.tio, _0_BlockTreeOrds_0.tipo, _4.fdt, _4.fdx, _4.fnm, _4.nvd, _4.nvm, _4.si, _4_BlockTreeOrds_0.doc, _4_BlockTreeOrds_0.tio, _4_BlockTreeOrds_0.tipo, _6.fdt, _6.fdx, _6.fnm, _6.nvd, _6.nvm, _6.si, _6_BlockTreeOrds_0.doc, _6_BlockTreeOrds_0.tio, _6_BlockTreeOrds_0.tipo, _7.fdt, _7.fdx, _7.fnm, _7.nvd, _7.nvm, _7.si, _7_BlockTreeOrds_0.doc, _7_BlockTreeOrds_0.tio, _7_BlockTreeOrds_0.tipo, segments_2]}, {indexVersion=1436939928071,generation=3,filelist=[_0.fdt, _0.fdx, _0.fnm, _0.nvd, _0.nvm, _0.si, _0_BlockTreeOrds_0.doc, _0_BlockTreeOrds_0.tio, _0_BlockTreeOrds_0.tipo, _8.cfe, _8.cfs, _8.si, segments_3]}]> at __randomizedtesting.SeedInfo.seed([A108012B41E9020D:84DF1A1B31A10C0E]: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:1138) 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:483) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886) 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:365) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845) at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747) at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792) 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:39) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) 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:365) at java.lang.Thread.run(Thread.java:745) Build Log: [...truncated 10313 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_A108012B41E9020D-001/init-core-data-001 [junit4] 2> 282976 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[A108012B41E9020D]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) [junit4] 2> 282976 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[A108012B41E9020D]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /jbgv/oy [junit4] 2> 282987 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 282990 INFO (Thread-1574) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 282991 INFO (Thread-1574) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 283090 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.ZkTestServer start zk server on port:58829 [junit4] 2> 283091 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 283091 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 283098 INFO (zkCallback-151-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@234ba257 name:ZooKeeperConnection Watcher:127.0.0.1:58829 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 283099 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 283099 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 283099 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 283110 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 283111 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 283123 INFO (zkCallback-152-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@53081ded name:ZooKeeperConnection Watcher:127.0.0.1:58829/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 283123 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 283123 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 283123 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1 [junit4] 2> 283125 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards [junit4] 2> 283126 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection [junit4] 2> 283127 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards [junit4] 2> 283128 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] 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> 283128 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml [junit4] 2> 283130 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] 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> 283131 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml [junit4] 2> 283132 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] 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> 283132 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 283133 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] 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> 283134 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt [junit4] 2> 283135 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] 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> 283135 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt [junit4] 2> 283136 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] 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> 283137 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml [junit4] 2> 283138 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] 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> 283138 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 283139 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] 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> 283139 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 283141 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] 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> 283141 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 283142 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] 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> 283142 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 283144 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] 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> 283144 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt [junit4] 2> 283146 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 283146 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 283148 INFO (zkCallback-153-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@672b505a name:ZooKeeperConnection Watcher:127.0.0.1:58829/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 283148 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 283148 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 283459 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] 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_A108012B41E9020D-001/control-001/cores/collection1 [junit4] 2> 283461 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.e.j.s.Server jetty-9.2.11.v20150529 [junit4] 2> 283462 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@188ac5db{/jbgv/oy,null,AVAILABLE} [junit4] 2> 283496 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.e.j.s.ServerConnector Started ServerConnector@3aab80c1{SSL-http/1.1}{127.0.0.1:38656} [junit4] 2> 283496 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.e.j.s.Server Started @287107ms [junit4] 2> 283496 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] 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_A108012B41E9020D-001/tempDir-001/control/data, hostContext=/jbgv/oy, hostPort=38656, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_A108012B41E9020D-001/control-001/cores} [junit4] 2> 283498 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@c387f44 [junit4] 2> 283498 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_A108012B41E9020D-001/control-001/' [junit4] 2> 283520 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_A108012B41E9020D-001/control-001/solr.xml [junit4] 2> 283525 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_A108012B41E9020D-001/control-001/cores [junit4] 2> 283525 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.CoreContainer New CoreContainer 863378522 [junit4] 2> 283525 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] 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/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_A108012B41E9020D-001/control-001/] [junit4] 2> 283525 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.CoreContainer loading shared library: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_A108012B41E9020D-001/control-001/lib [junit4] 2> 283526 WARN (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_A108012B41E9020D-001/control-001/lib). [junit4] 2> 283534 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] 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> 283537 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 283538 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 283539 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 283539 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58829/solr [junit4] 2> 283539 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 283539 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 283540 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 283545 INFO (zkCallback-155-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@655b8611 name:ZooKeeperConnection Watcher:127.0.0.1:58829 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 283546 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 283546 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 283549 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 283550 INFO (zkCallback-156-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@67701666 name:ZooKeeperConnection Watcher:127.0.0.1:58829/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 283551 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 283552 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue [junit4] 2> 283554 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work [junit4] 2> 283555 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running [junit4] 2> 283557 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed [junit4] 2> 283559 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure [junit4] 2> 283561 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 283566 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 283567 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 283568 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:38656_jbgv%2Foy [junit4] 2> 283569 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:38656_jbgv%2Foy [junit4] 2> 283570 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect [junit4] 2> 283571 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election [junit4] 2> 283572 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 283573 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/94171179046076420-127.0.0.1:38656_jbgv%2Foy-n_0000000000 [junit4] 2> 283573 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:38656_jbgv%2Foy [junit4] 2> 283573 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader [junit4] 2> 283575 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.Overseer Overseer (id=94171179046076420-127.0.0.1:38656_jbgv%2Foy-n_0000000000) starting [junit4] 2> 283576 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work [junit4] 2> 283581 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=10000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 283582 INFO (OverseerStateUpdate-94171179046076420-127.0.0.1:38656_jbgv%2Foy-n_0000000000) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.Overseer Starting to work on the main queue [junit4] 2> 283583 INFO (OverseerCollectionProcessor-94171179046076420-127.0.0.1:38656_jbgv%2Foy-n_0000000000) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.OverseerCollectionProcessor Process current queue of collection creations [junit4] 2> 283584 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 283586 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 283587 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 283587 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.CoresLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_A108012B41E9020D-001/control-001/cores [junit4] 2> 283588 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_A108012B41E9020D-001/control-001/cores/collection1, collection=control_collection, absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_A108012B41E9020D-001/control-001/cores/collection1/, coreNodeName=, dataDir=data/, shard=} [junit4] 2> 283589 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.CoresLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_A108012B41E9020D-001/control-001/cores/collection1/ [junit4] 2> 283589 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.CoresLocator Found 1 core definitions [junit4] 2> 283590 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection x:collection1] o.a.s.c.ZkController publishing state=down [junit4] 2> 283590 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 283590 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection x:collection1] o.a.s.c.ZkController look for our core node name [junit4] 2> 283594 INFO (zkCallback-156-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 283595 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1 [junit4] 2> 283595 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 283595 INFO (OverseerStateUpdate-94171179046076420-127.0.0.1:38656_jbgv%2Foy-n_0000000000) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:38656/jbgv/oy", [junit4] 2> "node_name":"127.0.0.1:38656_jbgv%2Foy", [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> 283596 INFO (OverseerStateUpdate-94171179046076420-127.0.0.1:38656_jbgv%2Foy-n_0000000000) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={ [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:38656/jbgv/oy", [junit4] 2> "node_name":"127.0.0.1:38656_jbgv%2Foy", [junit4] 2> "numShards":"1", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 283596 INFO (OverseerStateUpdate-94171179046076420-127.0.0.1:38656_jbgv%2Foy-n_0000000000) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.o.ClusterStateMutator building a new cName: control_collection [junit4] 2> 283597 INFO (OverseerStateUpdate-94171179046076420-127.0.0.1:38656_jbgv%2Foy-n_0000000000) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1 [junit4] 2> 283598 INFO (zkCallback-156-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy ] 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> 283599 INFO (zkCallback-156-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.c.ZkStateReader Updated cluster state version to 1 [junit4] 2> 284591 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection x:collection1] o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1 [junit4] 2> 284591 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection x:collection1] o.a.s.c.ZkController Check for collection zkNode:control_collection [junit4] 2> 284591 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection x:collection1] o.a.s.c.ZkController Collection zkNode exists [junit4] 2> 284592 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection x:collection1] o.a.s.c.c.ZkStateReader Load collection config from:/collections/control_collection [junit4] 2> 284592 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection x:collection1] o.a.s.c.c.ZkStateReader path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper [junit4] 2> 284592 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy 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/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_A108012B41E9020D-001/control-001/cores/collection1/' [junit4] 2> 284607 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection x:collection1] o.a.s.c.Config loaded config solrconfig.xml with version 0 [junit4] 2> 284612 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 284616 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0 [junit4] 2> 284624 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection x:collection1] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml [junit4] 2> 284625 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection x:collection1] o.a.s.s.IndexSchema Reading Solr Schema from /configs/conf1/schema.xml [junit4] 2> 284629 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 284722 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 284728 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection x:collection1] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 284729 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection x:collection1] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 284737 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 284739 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 284741 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 284742 WARN (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE [junit4] 2> 284742 WARN (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING [junit4] 2> 284742 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 284743 WARN (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE [junit4] 2> 284743 WARN (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING [junit4] 2> 284744 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection x:collection1] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties [junit4] 2> org.apache.solr.core.SolrResourceNotFoundException: 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> at org.apache.solr.cloud.ZkSolrResourceLoader.openResource(ZkSolrResourceLoader.java:99) [junit4] 2> at org.apache.solr.core.ConfigSetProperties.readFromResourceLoader(ConfigSetProperties.java:49) [junit4] 2> at org.apache.solr.core.ConfigSetService.createConfigSetProperties(ConfigSetService.java:114) [junit4] 2> at org.apache.solr.core.ConfigSetService.getConfig(ConfigSetService.java:76) [junit4] 2> at org.apache.solr.core.CoreContainer.create(CoreContainer.java:668) [junit4] 2> at org.apache.solr.core.CoreContainer$1.call(CoreContainer.java:397) [junit4] 2> at org.apache.solr.core.CoreContainer$1.call(CoreContainer.java:388) [junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:156) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> 284745 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection control_collection [junit4] 2> 284745 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 284745 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy 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/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_A108012B41E9020D-001/control-001/cores/collection1/], dataDir=[null] [junit4] 2> 284745 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy 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@e909f2f [junit4] 2> 284746 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy 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/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_A108012B41E9020D-001/control-001/cores/collection1/data [junit4] 2> 284746 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy 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/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_A108012B41E9020D-001/control-001/cores/collection1/data/index/ [junit4] 2> 284746 WARN (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy 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/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_A108012B41E9020D-001/control-001/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 284747 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy 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/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_A108012B41E9020D-001/control-001/cores/collection1/data/index [junit4] 2> 284747 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=18, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.21261105087057466] [junit4] 2> 284748 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@765e995a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@22262a2e),segFN=segments_1,generation=1} [junit4] 2> 284748 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 284748 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:38656_jbgv%2Foy 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/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_A108012B41E9020D-001/control-001/cores/collection1/data/ [junit4] 2> 284749 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:38656_jbgv%2Foy 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/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_A108012B41E9020D-001/control-001/cores/collection1/data/ does not point to a valid data directory; skipping clean-up of old index directories. [junit4] 2> 284753 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "nodistrib" [junit4] 2> 284754 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe" [junit4] 2> 284754 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 284754 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig" [junit4] 2> 284754 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 284754 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy 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> 284755 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy 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> 284755 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy 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> 284755 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy 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> 284757 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 284758 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 284759 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 284760 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 284764 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file [junit4] 2> 284765 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy 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> 284765 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy 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> 284765 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy 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> 284766 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled [junit4] 2> 284766 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled [junit4] 2> 284767 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=43, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 284770 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@765e995a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@22262a2e),segFN=segments_1,generation=1} [junit4] 2> 284770 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 284770 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@6c8167a[collection1] main [junit4] 2> 284771 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy 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> 284771 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy 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> 284771 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy 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> 284772 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 284772 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {} [junit4] 2> 284772 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy 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> 284772 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy 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> 284773 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy 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> 284773 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 284773 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 284774 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy 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> 284774 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy 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> 284774 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy 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> 284774 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy 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 1506738866605785088 [junit4] 2> 284776 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Took 2 ms to seed version buckets with highest version 1506738866605785088 [junit4] 2> 284776 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1 [junit4] 2> 284777 INFO (coreLoadExecutor-674-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 284778 INFO (searcherExecutor-675-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6c8167a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 284778 INFO (coreZkRegister-668-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController Register replica - core:collection1 address:https://127.0.0.1:38656/jbgv/oy collection:control_collection shard:shard1 [junit4] 2> 284779 INFO (coreZkRegister-668-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38656_jbgv%2Foy 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> 284783 INFO (coreZkRegister-668-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38656_jbgv%2Foy 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/94171179046076420-core_node1-n_0000000000 [junit4] 2> 284784 INFO (coreZkRegister-668-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Running the leader process for shard shard1 [junit4] 2> 284785 INFO (zkCallback-156-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 284785 INFO (coreZkRegister-668-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 284786 INFO (coreZkRegister-668-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38656_jbgv%2Foy 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> 284786 INFO (coreZkRegister-668-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:38656/jbgv/oy/collection1/ [junit4] 2> 284786 INFO (OverseerStateUpdate-94171179046076420-127.0.0.1:38656_jbgv%2Foy-n_0000000000) [n:127.0.0.1:38656_jbgv%2Foy ] 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> 284786 INFO (coreZkRegister-668-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 284786 INFO (coreZkRegister-668-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy https://127.0.0.1:38656/jbgv/oy/collection1/ has no replicas [junit4] 2> 284786 INFO (coreZkRegister-668-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:38656/jbgv/oy/collection1/ shard1 [junit4] 2> 284787 INFO (coreZkRegister-668-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1 [junit4] 2> 284790 INFO (zkCallback-156-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 284791 INFO (OverseerStateUpdate-94171179046076420-127.0.0.1:38656_jbgv%2Foy-n_0000000000) [n:127.0.0.1:38656_jbgv%2Foy ] 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":"https://127.0.0.1:38656/jbgv/oy", [junit4] 2> "core":"collection1", [junit4] 2> "state":"active"} current state version: 1 [junit4] 2> 284894 INFO (zkCallback-156-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy ] 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> 284896 INFO (zkCallback-156-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.c.ZkStateReader Updated cluster state version to 2 [junit4] 2> 284941 INFO (coreZkRegister-668-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController We are https://127.0.0.1:38656/jbgv/oy/collection1/ and leader is https://127.0.0.1:38656/jbgv/oy/collection1/ [junit4] 2> 284941 INFO (coreZkRegister-668-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController No LogReplay needed for core=collection1 baseURL=https://127.0.0.1:38656/jbgv/oy [junit4] 2> 284941 INFO (coreZkRegister-668-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 284942 INFO (coreZkRegister-668-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38656_jbgv%2Foy c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController publishing state=active [junit4] 2> 284942 INFO (coreZkRegister-668-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38656_jbgv%2Foy 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> 284943 INFO (zkCallback-156-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 284944 INFO (OverseerStateUpdate-94171179046076420-127.0.0.1:38656_jbgv%2Foy-n_0000000000) [n:127.0.0.1:38656_jbgv%2Foy ] 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":"https://127.0.0.1:38656/jbgv/oy", [junit4] 2> "node_name":"127.0.0.1:38656_jbgv%2Foy", [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> 284945 INFO (OverseerStateUpdate-94171179046076420-127.0.0.1:38656_jbgv%2Foy-n_0000000000) [n:127.0.0.1:38656_jbgv%2Foy ] 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":"https://127.0.0.1:38656/jbgv/oy", [junit4] 2> "node_name":"127.0.0.1:38656_jbgv%2Foy", [junit4] 2> "numShards":"1", [junit4] 2> "state":"active", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 285048 INFO (zkCallback-156-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy ] 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> 285049 INFO (zkCallback-156-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.c.ZkStateReader Updated cluster state version to 3 [junit4] 2> 285099 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 285100 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 285101 INFO (zkCallback-158-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@e453083 name:ZooKeeperConnection Watcher:127.0.0.1:58829/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 285102 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 285102 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 285102 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 285104 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false [junit4] 2> 285474 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] 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_A108012B41E9020D-001/shard-1-001/cores/collection1 [junit4] 2> 285475 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] 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_A108012B41E9020D-001/shard-1-001 [junit4] 2> 285476 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.e.j.s.Server jetty-9.2.11.v20150529 [junit4] 2> 285478 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@417186fb{/jbgv/oy,null,AVAILABLE} [junit4] 2> 285482 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.e.j.s.ServerConnector Started ServerConnector@314abee8{SSL-http/1.1}{127.0.0.1:50779} [junit4] 2> 285482 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.e.j.s.Server Started @289093ms [junit4] 2> 285482 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] 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_A108012B41E9020D-001/tempDir-001/jetty1, solrconfig=solrconfig.xml, hostContext=/jbgv/oy, hostPort=50779, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_A108012B41E9020D-001/shard-1-001/cores} [junit4] 2> 285484 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@c387f44 [junit4] 2> 285484 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] 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_A108012B41E9020D-001/shard-1-001/' [junit4] 2> 285499 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] 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_A108012B41E9020D-001/shard-1-001/solr.xml [junit4] 2> 285505 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_A108012B41E9020D-001/shard-1-001/cores [junit4] 2> 285505 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.CoreContainer New CoreContainer 730521635 [junit4] 2> 285505 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] 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_A108012B41E9020D-001/shard-1-001/] [junit4] 2> 285505 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.CoreContainer loading shared library: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_A108012B41E9020D-001/shard-1-001/lib [junit4] 2> 285505 WARN (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_A108012B41E9020D-001/shard-1-001/lib). [junit4] 2> 285512 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] 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> 285515 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 285522 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 285522 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 285523 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58829/solr [junit4] 2> 285523 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 285523 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 285552 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 285559 INFO (zkCallback-160-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6a5930d7 name:ZooKeeperConnection Watcher:127.0.0.1:58829 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 285559 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 285560 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 285562 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:50779_jbgv%2Foy ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 285567 INFO (zkCallback-161-thread-1-processing-n:127.0.0.1:50779_jbgv%2Foy) [n:127.0.0.1:50779_jbgv%2Foy ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2b6df771 name:ZooKeeperConnection Watcher:127.0.0.1:58829/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 285567 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:50779_jbgv%2Foy ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 285572 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:50779_jbgv%2Foy ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 286576 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:50779_jbgv%2Foy ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:50779_jbgv%2Foy [junit4] 2> 286576 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:50779_jbgv%2Foy ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:50779_jbgv%2Foy [junit4] 2> 286579 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:50779_jbgv%2Foy ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 286580 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:50779_jbgv%2Foy ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/94171179046076423-127.0.0.1:50779_jbgv%2Foy-n_0000000001 [junit4] 2> 286580 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:50779_jbgv%2Foy ] o.a.s.c.LeaderElector Watching path /overseer_elect/election/94171179046076420-127.0.0.1:38656_jbgv%2Foy-n_0000000000 to know if I could be the leader [junit4] 2> 286581 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:50779_jbgv%2Foy ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 286581 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:50779_jbgv%2Foy ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 286582 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:50779_jbgv%2Foy ] o.a.s.c.CoresLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_A108012B41E9020D-001/shard-1-001/cores [junit4] 2> 286583 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:50779_jbgv%2Foy ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_A108012B41E9020D-001/shard-1-001/cores/collection1, collection=collection1, absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_A108012B41E9020D-001/shard-1-001/cores/collection1/, coreNodeName=, dataDir=data/, shard=} [junit4] 2> 286583 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:50779_jbgv%2Foy ] o.a.s.c.CoresLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_A108012B41E9020D-001/shard-1-001/cores/collection1/ [junit4] 2> 286583 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:50779_jbgv%2Foy ] o.a.s.c.CoresLocator Found 1 core definitions [junit4] 2> 286584 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:50779_jbgv%2Foy ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1 [junit4] 2> 286584 INFO (coreLoadExecutor-685-thread-1-processing-n:127.0.0.1:50779_jbgv%2Foy) [n:127.0.0.1:50779_jbgv%2Foy c:collection1 x:collection1] o.a.s.c.ZkController publishing state=down [junit4] 2> 286584 INFO (coreLoadExecutor-685-thread-1-processing-n:127.0.0.1:50779_jbgv%2Foy) [n:127.0.0.1:50779_jbgv%2Foy c:collection1 x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 286584 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[A108012B41E9020D]) [n:127.0.0.1:50779_jbgv%2Foy ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 286585 INFO (zkCallback-156-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 286585 INFO (coreLoadExecutor-685-thread-1-processing-n:127.0.0.1:50779_jbgv%2Foy) [n:127.0.0.1:50779_jbgv%2Foy c:collection1 x:collection1] o.a.s.c.ZkController look for our core node name [junit4] 2> 286586 INFO (OverseerStateUpdate-94171179046076420-127.0.0.1:38656_jbgv%2Foy-n_0000000000) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:50779/jbgv/oy", [junit4] 2> "node_name":"127.0.0.1:50779_jbgv%2Foy", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"collection1", [junit4] 2> "operation":"state"} current state version: 3 [junit4] 2> 286587 INFO (OverseerStateUpdate-94171179046076420-127.0.0.1:38656_jbgv%2Foy-n_0000000000) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={ [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:50779/jbgv/oy", [junit4] 2> "node_name":"127.0.0.1:50779_jbgv%2Foy", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"collection1", [junit4] 2> "operation":"state"} [junit4] 2> 286587 INFO (OverseerStateUpdate-94171179046076420-127.0.0.1:38656_jbgv%2Foy-n_0000000000) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.o.ClusterStateMutator building a new cName: collection1 [junit4] 2> 286587 INFO (OverseerStateUpdate-94171179046076420-127.0.0.1:38656_jbgv%2Foy-n_0000000000) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard2 [junit4] 2> 286588 INFO (zkCallback-161-thread-1-processing-n:127.0.0.1:50779_jbgv%2Foy) [n:127.0.0.1:50779_jbgv%2Foy ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2) [junit4] 2> 286588 INFO (zkCallback-158-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2) [junit4] 2> 286589 INFO (zkCallback-156-thread-1-processing-n:127.0.0.1:38656_jbgv%2Foy) [n:127.0.0.1:38656_jbgv%2Foy ] o.a.s.c.c.ZkStateReader A cluster state c [...truncated too long message...] org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1720) [junit4] 2> at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1699) [junit4] 2> at org.apache.solr.cloud.hdfs.HdfsTestUtil.teardownClass(HdfsTestUtil.java:197) [junit4] 2> at org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.teardownClass(HdfsCollectionsAPIDistributedZkTest.java:50) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] 2> at java.lang.reflect.Method.invoke(Method.java:483) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:799) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> Caused by: java.lang.NullPointerException [junit4] 2> at org.apache.hadoop.hdfs.server.blockmanagement.BlocksMap.size(BlocksMap.java:198) [junit4] 2> at org.apache.hadoop.hdfs.server.blockmanagement.BlockManager.getTotalBlocks(BlockManager.java:3291) [junit4] 2> at org.apache.hadoop.hdfs.server.namenode.FSNamesystem.getBlocksTotal(FSNamesystem.java:6223) [junit4] 2> ... 53 more [junit4] 2> 4703419 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[A108012B41E9020D]-worker) [n:127.0.0.1:41345_zqga%2Fv c:addReplicaColl s:shard2 r:core_node6 x:addReplicaColl_shard2_replica3] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> Jul 15, 2015 2:42:57 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 2 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Asserting(Lucene53): {other_tl1=PostingsFormat(name=LuceneVarGapFixedInterval), range_facet_l_dv=PostingsFormat(name=Memory doPackFST= true), _version_=PostingsFormat(name=LuceneVarGapFixedInterval), multiDefault=PostingsFormat(name=LuceneVarGapDocFreqInterval), a_t=PostingsFormat(name=LuceneVarGapFixedInterval), intDefault=PostingsFormat(name=LuceneVarGapFixedInterval), a_i1=PostingsFormat(name=LuceneVarGapFixedInterval), id=PostingsFormat(name=Memory doPackFST= true), range_facet_i_dv=PostingsFormat(name=LuceneVarGapFixedInterval), text=FST50, range_facet_l=PostingsFormat(name=LuceneVarGapFixedInterval), timestamp=PostingsFormat(name=LuceneVarGapFixedInterval)}, docValues:{range_facet_l_dv=DocValuesFormat(name=Memory), range_facet_i_dv=DocValuesFormat(name=Lucene50), timestamp=DocValuesFormat(name=Lucene50)}, sim=DefaultSimilarity, locale=ar_TN, timezone=Asia/Yakutsk [junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.8.0_25 (64-bit)/cpus=4,threads=2,free=75500376,total=525336576 [junit4] 2> NOTE: All tests run in this JVM: [HighlighterTest, CollectionReloadTest, MinimalSchemaTest, TestFreeTextSuggestions, TestSolrIndexConfig, QueryElevationComponentTest, TestSmileRequest, TestSolrDynamicMBean, DefaultValueUpdateProcessorTest, SimplePostToolTest, DistributedFacetPivotSmallAdvancedTest, TestNonDefinedSimilarityFactory, TestSweetSpotSimilarityFactory, SuggesterFSTTest, FacetPivotSmallTest, TestDefaultSearchFieldResource, TestRandomFaceting, TestStandardQParsers, UUIDFieldTest, ExitableDirectoryReaderTest, TestDynamicFieldResource, TestRemoteStreaming, TestInfoStreamLogging, MBeansHandlerTest, AssignTest, EnumFieldTest, TestCollapseQParserPlugin, TestSolrDeletionPolicy1, SolrIndexConfigTest, TestBlendedInfixSuggestions, TestRestoreCore, TestCodecSupport, SegmentsInfoRequestHandlerTest, TestFileDictionaryLookup, FastVectorHighlighterTest, AsyncCallRequestStatusResponseTest, TestSolrConfigHandler, SignatureUpdateProcessorFactoryTest, RequestHandlersTest, ParsingFieldUpdateProcessorsTest, TestJoin, LeaderElectionIntegrationTest, PeerSyncTest, BasicZkTest, TestStressLucene, DebugComponentTest, TestBinaryField, TestRangeQuery, ZkNodePropsTest, TestSimpleTrackingShardHandler, TestRealTimeGet, TestRTimer, AddBlockUpdateTest, ResponseHeaderTest, DistributedQueueTest, DistributedFacetPivotWhiteBoxTest, TestReRankQParserPlugin, DeleteInactiveReplicaTest, RollingRestartTest, TestDistributedSearch, TestCloudManagedSchemaConcurrent, URLClassifyProcessorTest, HdfsDirectoryTest, TestReplicationHandler, TestLazyCores, DistributedFacetPivotLargeTest, SolrRequestParserTest, SyncSliceTest, TestFieldResource, TestConfigReload, LeaderFailoverAfterPartitionTest, TestSolrConfigHandlerConcurrent, DataDrivenBlockJoinTest, PrimitiveFieldTypeTest, ConnectionManagerTest, ExternalFileFieldSortTest, TestLeaderElectionZkExpiry, TestWordDelimiterFilterFactory, TestFunctionQuery, TestConfig, TestJsonFacets, TestSolrQueryParserResource, TestFieldTypeCollectionResource, TestEmbeddedSolrServerConstructors, TestOrdValues, FullSolrCloudDistribCmdsTest, LeaderElectionTest, ZkCLITest, AutoCommitTest, TestDistributedGrouping, TestFaceting, TestHashPartitioner, DistributedSpellCheckComponentTest, HardAutoCommitTest, TestCoreContainer, SolrCoreTest, StatsComponentTest, SolrCmdDistributorTest, BasicFunctionalityTest, TestIndexSearcher, SoftAutoCommitTest, CoreAdminHandlerTest, TestTrie, TestCSVLoader, SchemaVersionSpecificBehaviorTest, TestUpdate, TestAtomicUpdateErrorCases, StatelessScriptUpdateProcessorFactoryTest, TestSurroundQueryParser, DisMaxRequestHandlerTest, TestQueryUtils, TestWriterPerf, FileBasedSpellCheckerTest, TestValueSourceCache, TestIndexingPerformance, RequiredFieldsTest, LoggingHandlerTest, TestJmxIntegration, UpdateRequestProcessorFactoryTest, QueryParsingTest, UniqFieldsUpdateProcessorFactoryTest, CSVRequestHandlerTest, TestBinaryResponseWriter, SOLR749Test, UpdateParamsTest, BadComponentTest, MultiTermTest, TestSearchPerf, TestElisionMultitermQuery, NotRequiredUniqueKeyTest, TestPhraseSuggestions, SynonymTokenizerTest, TestXIncludeConfig, TestLMJelinekMercerSimilarityFactory, TestDefaultSimilarityFactory, TimeZoneUtilsTest, ScriptEngineTest, OpenExchangeRatesOrgProviderTest, ChaosMonkeyNothingIsSafeTest, CollectionTooManyReplicasTest, DistribCursorPagingTest, DistributedVersionInfoTest, MultiThreadedOCPTest, OverseerStatusTest, SSLMigrationTest, SaslZkACLProviderTest, SharedFSAutoReplicaFailoverTest, HdfsCollectionsAPIDistributedZkTest] [junit4] Completed [517/517] on J0 in 1084.14s, 1 test, 1 error <<< FAILURES! [...truncated 13 lines...] BUILD FAILED /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:533: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:474: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:61: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/extra-targets.xml:39: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build.xml:230: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/common-build.xml:513: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:1426: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:981: There were test failures: 517 suites, 2032 tests, 2 errors, 1 failure, 20 ignored (10 assumptions) Total time: 194 minutes 47 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 Sending email for trigger: Failure
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org