Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-trunk/751/
4 tests failed. REGRESSION: org.apache.solr.cloud.BasicDistributedZkTest.test Error Message: Error from server at http://127.0.0.1:53402/z_tne/fh/collection1: Bad Request request: http://127.0.0.1:57983/z_tne/fh/collection1/update?update.chain=distrib-dup-test-chain-explicit&update.distrib=TOLEADER&distrib.from=http%3A%2F%2F127.0.0.1%3A53402%2Fz_tne%2Ffh%2Fcollection1%2F&wt=javabin&version=2 Stack Trace: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:53402/z_tne/fh/collection1: Bad Request request: http://127.0.0.1:57983/z_tne/fh/collection1/update?update.chain=distrib-dup-test-chain-explicit&update.distrib=TOLEADER&distrib.from=http%3A%2F%2F127.0.0.1%3A53402%2Fz_tne%2Ffh%2Fcollection1%2F&wt=javabin&version=2 at __randomizedtesting.SeedInfo.seed([C79B1F20C326140B:4FCF20FA6DDA79F3]: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.SolrRequest.process(SolrRequest.java:135) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:152) at org.apache.solr.BaseDistributedSearchTestCase.add(BaseDistributedSearchTestCase.java:511) at org.apache.solr.cloud.BasicDistributedZkTest.testUpdateProcessorsRunOnlyOnce(BasicDistributedZkTest.java:639) at org.apache.solr.cloud.BasicDistributedZkTest.test(BasicDistributedZkTest.java:350) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:497) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java: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 org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:963) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:938) 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) FAILED: org.apache.solr.cloud.ChaosMonkeySafeLeaderTest.test Error Message: shard4 is not consistent. Got 224 from http://127.0.0.1:50984/rxo/ne/collection1lastClient and got 163 from http://127.0.0.1:60838/rxo/ne/collection1 Stack Trace: java.lang.AssertionError: shard4 is not consistent. Got 224 from http://127.0.0.1:50984/rxo/ne/collection1lastClient and got 163 from http://127.0.0.1:60838/rxo/ne/collection1 at __randomizedtesting.SeedInfo.seed([C79B1F20C326140B:4FCF20FA6DDA79F3]:0) at org.junit.Assert.fail(Assert.java:93) at org.apache.solr.cloud.AbstractFullDistribZkTestBase.checkShardConsistency(AbstractFullDistribZkTestBase.java:1244) at org.apache.solr.cloud.AbstractFullDistribZkTestBase.checkShardConsistency(AbstractFullDistribZkTestBase.java:1223) at org.apache.solr.cloud.ChaosMonkeySafeLeaderTest.test(ChaosMonkeySafeLeaderTest.java:165) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:497) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java: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 org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:963) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:938) 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) FAILED: org.apache.solr.cloud.FullSolrCloudDistribCmdsTest.test Error Message: Captured an uncaught exception in thread: Thread[id=2905, name=Thread-1466, state=RUNNABLE, group=TGRP-FullSolrCloudDistribCmdsTest] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=2905, name=Thread-1466, state=RUNNABLE, group=TGRP-FullSolrCloudDistribCmdsTest] Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:47538/i/bi/collection1 at __randomizedtesting.SeedInfo.seed([C79B1F20C326140B]:0) at org.apache.solr.cloud.FullSolrCloudDistribCmdsTest$1IndexThread.run(FullSolrCloudDistribCmdsTest.java:645) Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:47538/i/bi/collection1 at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:572) 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.SolrRequest.process(SolrRequest.java:135) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:152) at org.apache.solr.cloud.FullSolrCloudDistribCmdsTest$1IndexThread.run(FullSolrCloudDistribCmdsTest.java:643) Caused by: java.net.SocketTimeoutException: Read timed out at java.net.SocketInputStream.socketRead0(Native Method) at java.net.SocketInputStream.socketRead(SocketInputStream.java:116) at java.net.SocketInputStream.read(SocketInputStream.java:170) at java.net.SocketInputStream.read(SocketInputStream.java:141) at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160) at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84) at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57) at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261) at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283) at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251) at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197) at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272) at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124) at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685) at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487) at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:465) ... 5 more FAILED: org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.test Error Message: Captured an uncaught exception in thread: Thread[id=76910, name=collection3, state=RUNNABLE, group=TGRP-HdfsCollectionsAPIDistributedZkTest] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=76910, name=collection3, state=RUNNABLE, group=TGRP-HdfsCollectionsAPIDistributedZkTest] Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:37005/xxso: Could not find collection : awholynewstresscollection_collection3_0 at __randomizedtesting.SeedInfo.seed([C79B1F20C326140B]: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) Build Log: [...truncated 10354 lines...] [junit4] Suite: org.apache.solr.cloud.FullSolrCloudDistribCmdsTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/init-core-data-001 [junit4] 2> 370004 INFO (SUITE-FullSolrCloudDistribCmdsTest-seed#[C79B1F20C326140B]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /i/bi [junit4] 2> 370014 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 370033 INFO (Thread-1301) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 370033 INFO (Thread-1301) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 370130 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.ZkTestServer start zk server on port:39568 [junit4] 2> 370130 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 370148 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 370157 INFO (zkCallback-315-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4730a2af name:ZooKeeperConnection Watcher:127.0.0.1:39568 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 370160 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 370160 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 370160 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 370163 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 370172 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 370188 INFO (zkCallback-316-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@637d0c00 name:ZooKeeperConnection Watcher:127.0.0.1:39568/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 370188 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 370188 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 370189 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1 [junit4] 2> 370190 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards [junit4] 2> 370191 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection [junit4] 2> 370192 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards [junit4] 2> 370194 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] 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> 370194 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml [junit4] 2> 370196 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/schema15.xml to /configs/conf1/schema.xml [junit4] 2> 370196 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml [junit4] 2> 370197 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] 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> 370198 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 370199 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] 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> 370199 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt [junit4] 2> 370200 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] 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> 370200 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt [junit4] 2> 370202 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] 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> 370202 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml [junit4] 2> 370203 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] 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> 370203 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 370205 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] 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> 370205 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 370206 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] 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> 370206 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 370207 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] 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> 370208 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 370209 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] 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> 370209 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt [junit4] 2> 371261 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/control-001/cores/collection1 [junit4] 2> 371282 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.e.j.s.Server jetty-9.2.11.v20150529 [junit4] 2> 371359 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@48ef1fa9{/i/bi,null,AVAILABLE} [junit4] 2> 371364 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.e.j.s.ServerConnector Started ServerConnector@103057a4{HTTP/1.1}{127.0.0.1:47538} [junit4] 2> 371364 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.e.j.s.Server Started @375083ms [junit4] 2> 371364 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] 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/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/tempDir-001/control/data, hostContext=/i/bi, hostPort=47538, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/control-001/cores} [junit4] 2> 371365 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a [junit4] 2> 371365 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/control-001/' [junit4] 2> 371454 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 371474 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 371490 INFO (zkCallback-317-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@718a9491 name:ZooKeeperConnection Watcher:127.0.0.1:39568/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 371491 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 371492 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 371495 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 371496 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/control-001/solr.xml [junit4] 2> 371504 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/control-001/cores [junit4] 2> 371504 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.CoreContainer New CoreContainer 2073830545 [junit4] 2> 371504 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/control-001/] [junit4] 2> 371505 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.CoreContainer loading shared library: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/control-001/lib [junit4] 2> 371505 WARN (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] 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/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/control-001/lib). [junit4] 2> 371526 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] 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> 371528 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 371529 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 371529 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 371529 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39568/solr [junit4] 2> 371529 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 371529 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 371536 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 371548 INFO (zkCallback-319-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7600c3e4 name:ZooKeeperConnection Watcher:127.0.0.1:39568 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 371550 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 371551 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 371566 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 371580 INFO (zkCallback-320-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5790f96e name:ZooKeeperConnection Watcher:127.0.0.1:39568/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 371580 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 371582 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue [junit4] 2> 371587 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work [junit4] 2> 371589 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running [junit4] 2> 371591 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed [junit4] 2> 371593 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure [junit4] 2> 371595 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 371597 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 371599 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 371600 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:47538_i%2Fbi [junit4] 2> 371600 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:47538_i%2Fbi [junit4] 2> 371602 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect [junit4] 2> 371604 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election [junit4] 2> 371605 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 371606 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/94252850502172676-127.0.0.1:47538_i%2Fbi-n_0000000000 [junit4] 2> 371606 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:47538_i%2Fbi [junit4] 2> 371607 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader [junit4] 2> 371608 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.Overseer Overseer (id=94252850502172676-127.0.0.1:47538_i%2Fbi-n_0000000000) starting [junit4] 2> 371609 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work [junit4] 2> 371616 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 371618 INFO (OverseerStateUpdate-94252850502172676-127.0.0.1:47538_i%2Fbi-n_0000000000) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.Overseer Starting to work on the main queue [junit4] 2> 371622 INFO (OverseerCollectionProcessor-94252850502172676-127.0.0.1:47538_i%2Fbi-n_0000000000) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.OverseerCollectionProcessor Process current queue of collection creations [junit4] 2> 371635 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 371637 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 371637 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 371638 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.CoresLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/control-001/cores [junit4] 2> 371639 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] 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/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/control-001/cores/collection1, collection=control_collection, absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/control-001/cores/collection1/, coreNodeName=, dataDir=data/, shard=} [junit4] 2> 371639 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.CoresLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/control-001/cores/collection1/ [junit4] 2> 371639 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.CoresLocator Found 1 core definitions [junit4] 2> 371641 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection x:collection1] o.a.s.c.ZkController publishing state=down [junit4] 2> 371641 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 371642 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection x:collection1] o.a.s.c.ZkController look for our core node name [junit4] 2> 371654 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2 [junit4] 2> 371654 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 371656 INFO (zkCallback-320-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 371657 INFO (OverseerStateUpdate-94252850502172676-127.0.0.1:47538_i%2Fbi-n_0000000000) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:47538/i/bi";, [junit4] 2> "node_name":"127.0.0.1:47538_i%2Fbi", [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> 371657 INFO (OverseerStateUpdate-94252850502172676-127.0.0.1:47538_i%2Fbi-n_0000000000) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={ [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:47538/i/bi";, [junit4] 2> "node_name":"127.0.0.1:47538_i%2Fbi", [junit4] 2> "numShards":"1", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 371657 INFO (OverseerStateUpdate-94252850502172676-127.0.0.1:47538_i%2Fbi-n_0000000000) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.o.ClusterStateMutator building a new cName: control_collection [junit4] 2> 371658 INFO (OverseerStateUpdate-94252850502172676-127.0.0.1:47538_i%2Fbi-n_0000000000) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1 [junit4] 2> 371659 INFO (zkCallback-320-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi ] 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> 371661 INFO (zkCallback-320-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.c.ZkStateReader Updated cluster state version to 1 [junit4] 2> 372687 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection x:collection1] o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1 [junit4] 2> 372688 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection x:collection1] o.a.s.c.ZkController Check for collection zkNode:control_collection [junit4] 2> 372689 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection x:collection1] o.a.s.c.ZkController Collection zkNode exists [junit4] 2> 372689 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection x:collection1] o.a.s.c.c.ZkStateReader Load collection config from:/collections/control_collection [junit4] 2> 372689 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection x:collection1] o.a.s.c.c.ZkStateReader path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper [junit4] 2> 372690 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi 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/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/control-001/cores/collection1/' [junit4] 2> 372715 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection x:collection1] o.a.s.c.Config loaded config solrconfig.xml with version 0 [junit4] 2> 372722 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 372742 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0 [junit4] 2> 372801 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection x:collection1] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml [junit4] 2> 372804 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection x:collection1] o.a.s.s.IndexSchema Reading Solr Schema from /configs/conf1/schema.xml [junit4] 2> 372812 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 373049 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection x:collection1] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 373050 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection x:collection1] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 373051 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 373054 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 373073 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection x:collection1] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/configs/conf1', cwd=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2 [junit4] 2> 373073 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection control_collection [junit4] 2> 373073 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 373073 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi 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/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/control-001/cores/collection1/], dataDir=[null] [junit4] 2> 373074 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi 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@75cdf8a5 [junit4] 2> 373074 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi 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/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/control-001/cores/collection1/data [junit4] 2> 373074 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi 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/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/control-001/cores/collection1/data/index/ [junit4] 2> 373075 WARN (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi 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/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/control-001/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 373075 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi 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/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/control-001/cores/collection1/data/index [junit4] 2> 373075 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi 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=42, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.45796182512378525] [junit4] 2> 373076 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=RawDirectoryWrapper(RAMDirectory@63c4a7f1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2ae79ef1),segFN=segments_1,generation=1} [junit4] 2> 373076 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 373094 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "nodistrib" [junit4] 2> 373094 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe" [junit4] 2> 373094 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 373094 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig" [junit4] 2> 373094 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 373095 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi 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> 373095 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi 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> 373095 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi 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> 373098 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi 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> 373098 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:47538_i%2Fbi 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/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/control-001/cores/collection1/data/ [junit4] 2> 373098 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:47538_i%2Fbi 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/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/control-001/cores/collection1/data/ does not point to a valid data directory; skipping clean-up of old index directories. [junit4] 2> 373104 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 373107 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 373108 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 373109 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 373112 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi 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> 373113 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi 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> 373132 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi 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> 373139 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi 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> 373142 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled [junit4] 2> 373142 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled [junit4] 2> 373143 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@47f10dac [junit4] 2> 373209 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=RawDirectoryWrapper(RAMDirectory@63c4a7f1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2ae79ef1),segFN=segments_1,generation=1} [junit4] 2> 373209 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 373210 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@1919988f[collection1] main [junit4] 2> 373210 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi 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> 373212 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi 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> 373212 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi 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> 373213 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 373213 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {} [junit4] 2> 373213 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi 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> 373214 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi 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> 373214 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi 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> 373214 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 373214 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 373214 INFO (searcherExecutor-811-thread-1-processing-n:127.0.0.1:47538_i%2Fbi x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1919988f[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 373215 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi 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> 373215 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi 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> 373215 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi 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> 373215 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi 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 1508045611368185856 [junit4] 2> 373217 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi 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 1508045611368185856 [junit4] 2> 373218 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1 [junit4] 2> 373218 INFO (coreLoadExecutor-810-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 373234 INFO (coreZkRegister-804-thread-1-processing-n:127.0.0.1:47538_i%2Fbi x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController Register replica - core:collection1 address:http://127.0.0.1:47538/i/bi collection:control_collection shard:shard1 [junit4] 2> 373235 INFO (coreZkRegister-804-thread-1-processing-n:127.0.0.1:47538_i%2Fbi x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:47538_i%2Fbi 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> 373276 INFO (coreZkRegister-804-thread-1-processing-n:127.0.0.1:47538_i%2Fbi x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:47538_i%2Fbi 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/94252850502172676-core_node1-n_0000000000 [junit4] 2> 373277 INFO (coreZkRegister-804-thread-1-processing-n:127.0.0.1:47538_i%2Fbi x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Running the leader process for shard shard1 [junit4] 2> 373279 INFO (zkCallback-320-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 373279 INFO (coreZkRegister-804-thread-1-processing-n:127.0.0.1:47538_i%2Fbi x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 373279 INFO (coreZkRegister-804-thread-1-processing-n:127.0.0.1:47538_i%2Fbi x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:47538_i%2Fbi 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> 373280 INFO (coreZkRegister-804-thread-1-processing-n:127.0.0.1:47538_i%2Fbi x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:47538/i/bi/collection1/ [junit4] 2> 373280 INFO (OverseerStateUpdate-94252850502172676-127.0.0.1:47538_i%2Fbi-n_0000000000) [n:127.0.0.1:47538_i%2Fbi ] 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> 373282 INFO (zkCallback-320-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi ] 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> 373283 INFO (zkCallback-320-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.c.ZkStateReader Updated cluster state version to 2 [junit4] 2> 373285 INFO (coreZkRegister-804-thread-1-processing-n:127.0.0.1:47538_i%2Fbi x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 373285 INFO (coreZkRegister-804-thread-1-processing-n:127.0.0.1:47538_i%2Fbi x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:47538/i/bi/collection1/ has no replicas [junit4] 2> 373285 INFO (coreZkRegister-804-thread-1-processing-n:127.0.0.1:47538_i%2Fbi x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:47538/i/bi/collection1/ shard1 [junit4] 2> 373285 INFO (coreZkRegister-804-thread-1-processing-n:127.0.0.1:47538_i%2Fbi x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1 [junit4] 2> 373290 INFO (zkCallback-320-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 373291 INFO (OverseerStateUpdate-94252850502172676-127.0.0.1:47538_i%2Fbi-n_0000000000) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"leader", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "base_url":"http://127.0.0.1:47538/i/bi";, [junit4] 2> "core":"collection1", [junit4] 2> "state":"active"} current state version: 2 [junit4] 2> 373393 INFO (zkCallback-320-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi ] 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> 373395 INFO (zkCallback-320-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.c.ZkStateReader Updated cluster state version to 3 [junit4] 2> 373444 INFO (coreZkRegister-804-thread-1-processing-n:127.0.0.1:47538_i%2Fbi x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController We are http://127.0.0.1:47538/i/bi/collection1/ and leader is http://127.0.0.1:47538/i/bi/collection1/ [junit4] 2> 373444 INFO (coreZkRegister-804-thread-1-processing-n:127.0.0.1:47538_i%2Fbi x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:47538/i/bi [junit4] 2> 373444 INFO (coreZkRegister-804-thread-1-processing-n:127.0.0.1:47538_i%2Fbi x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 373444 INFO (coreZkRegister-804-thread-1-processing-n:127.0.0.1:47538_i%2Fbi x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:47538_i%2Fbi c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController publishing state=active [junit4] 2> 373445 INFO (coreZkRegister-804-thread-1-processing-n:127.0.0.1:47538_i%2Fbi x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:47538_i%2Fbi 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> 373446 INFO (zkCallback-320-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 373447 INFO (OverseerStateUpdate-94252850502172676-127.0.0.1:47538_i%2Fbi-n_0000000000) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "core":"collection1", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:47538/i/bi";, [junit4] 2> "node_name":"127.0.0.1:47538_i%2Fbi", [junit4] 2> "numShards":"1", [junit4] 2> "state":"active", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} current state version: 3 [junit4] 2> 373447 INFO (OverseerStateUpdate-94252850502172676-127.0.0.1:47538_i%2Fbi-n_0000000000) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={ [junit4] 2> "core":"collection1", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:47538/i/bi";, [junit4] 2> "node_name":"127.0.0.1:47538_i%2Fbi", [junit4] 2> "numShards":"1", [junit4] 2> "state":"active", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 373550 INFO (zkCallback-320-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi ] 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> 373552 INFO (zkCallback-320-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.c.ZkStateReader Updated cluster state version to 4 [junit4] 2> 373710 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 373732 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 373752 INFO (zkCallback-322-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4a7b43c6 name:ZooKeeperConnection Watcher:127.0.0.1:39568/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 373752 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 373752 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 373753 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 373755 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false [junit4] 2> 375387 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/shard-1-001/cores/collection1 [junit4] 2> 375394 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/shard-1-001 [junit4] 2> 375398 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.e.j.s.Server jetty-9.2.11.v20150529 [junit4] 2> 375422 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@31f67297{/i/bi,null,AVAILABLE} [junit4] 2> 375422 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.e.j.s.ServerConnector Started ServerConnector@5818c562{HTTP/1.1}{127.0.0.1:54911} [junit4] 2> 375423 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.e.j.s.Server Started @379141ms [junit4] 2> 375423 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] 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/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/tempDir-001/jetty1, solrconfig=solrconfig.xml, hostContext=/i/bi, hostPort=54911, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/shard-1-001/cores} [junit4] 2> 375423 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a [junit4] 2> 375423 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/shard-1-001/' [junit4] 2> 375461 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 375494 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 375508 INFO (zkCallback-323-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3627ff6b name:ZooKeeperConnection Watcher:127.0.0.1:39568/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 375512 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 375512 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 375514 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 375514 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/shard-1-001/solr.xml [junit4] 2> 375519 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/shard-1-001/cores [junit4] 2> 375519 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.CoreContainer New CoreContainer 1709897512 [junit4] 2> 375519 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/shard-1-001/] [junit4] 2> 375520 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.CoreContainer loading shared library: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/shard-1-001/lib [junit4] 2> 375520 WARN (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] 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/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/shard-1-001/lib). [junit4] 2> 375540 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] 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> 375542 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 375542 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 375542 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 375542 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39568/solr [junit4] 2> 375542 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 375542 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 375560 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 375584 INFO (zkCallback-325-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@208b83d4 name:ZooKeeperConnection Watcher:127.0.0.1:39568 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 375585 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 375585 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 375616 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:54911_i%2Fbi ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 375640 INFO (zkCallback-326-thread-1-processing-n:127.0.0.1:54911_i%2Fbi) [n:127.0.0.1:54911_i%2Fbi ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@342357e name:ZooKeeperConnection Watcher:127.0.0.1:39568/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 375640 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:54911_i%2Fbi ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 375644 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:54911_i%2Fbi ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 376683 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:54911_i%2Fbi ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:54911_i%2Fbi [junit4] 2> 376683 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:54911_i%2Fbi ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:54911_i%2Fbi [junit4] 2> 376686 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:54911_i%2Fbi ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 376686 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:54911_i%2Fbi ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/94252850502172680-127.0.0.1:54911_i%2Fbi-n_0000000001 [junit4] 2> 376687 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:54911_i%2Fbi ] o.a.s.c.LeaderElector Watching path /overseer_elect/election/94252850502172676-127.0.0.1:47538_i%2Fbi-n_0000000000 to know if I could be the leader [junit4] 2> 376687 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:54911_i%2Fbi ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 376687 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:54911_i%2Fbi ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 376688 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:54911_i%2Fbi ] o.a.s.c.CoresLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/shard-1-001/cores [junit4] 2> 376689 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:54911_i%2Fbi ] 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/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/shard-1-001/cores/collection1, collection=collection1, absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/shard-1-001/cores/collection1/, coreNodeName=, dataDir=data/, shard=} [junit4] 2> 376689 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:54911_i%2Fbi ] o.a.s.c.CoresLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_C79B1F20C326140B-001/shard-1-001/cores/collection1/ [junit4] 2> 376689 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:54911_i%2Fbi ] o.a.s.c.CoresLocator Found 1 core definitions [junit4] 2> 376694 INFO (coreLoadExecutor-821-thread-1-processing-n:127.0.0.1:54911_i%2Fbi) [n:127.0.0.1:54911_i%2Fbi c:collection1 x:collection1] o.a.s.c.ZkController publishing state=down [junit4] 2> 376695 INFO (coreLoadExecutor-821-thread-1-processing-n:127.0.0.1:54911_i%2Fbi) [n:127.0.0.1:54911_i%2Fbi c:collection1 x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 376700 INFO (zkCallback-320-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 376700 INFO (coreLoadExecutor-821-thread-1-processing-n:127.0.0.1:54911_i%2Fbi) [n:127.0.0.1:54911_i%2Fbi c:collection1 x:collection1] o.a.s.c.ZkController look for our core node name [junit4] 2> 376701 INFO (OverseerStateUpdate-94252850502172676-127.0.0.1:47538_i%2Fbi-n_0000000000) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:54911/i/bi";, [junit4] 2> "node_name":"127.0.0.1:54911_i%2Fbi", [junit4] 2> "numShards":"3", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"collection1", [junit4] 2> "operation":"state"} current state version: 4 [junit4] 2> 376701 INFO (OverseerStateUpdate-94252850502172676-127.0.0.1:47538_i%2Fbi-n_0000000000) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.o.ReplicaMutator Update state numShards=3 message={ [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:54911/i/bi";, [junit4] 2> "node_name":"127.0.0.1:54911_i%2Fbi", [junit4] 2> "numShards":"3", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"collection1", [junit4] 2> "operation":"state"} [junit4] 2> 376701 INFO (OverseerStateUpdate-94252850502172676-127.0.0.1:47538_i%2Fbi-n_0000000000) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.o.ClusterStateMutator building a new cName: collection1 [junit4] 2> 376702 INFO (OverseerStateUpdate-94252850502172676-127.0.0.1:47538_i%2Fbi-n_0000000000) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard2 [junit4] 2> 376703 INFO (zkCallback-326-thread-1-processing-n:127.0.0.1:54911_i%2Fbi) [n:127.0.0.1:54911_i%2Fbi ] 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> 376703 INFO (zkCallback-320-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi ] 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> 376704 INFO (zkCallback-326-thread-1-processing-n:127.0.0.1:54911_i%2Fbi) [n:127.0.0.1:54911_i%2Fbi ] o.a.s.c.c.ZkStateReader Updated cluster state version to 5 [junit4] 2> 376705 INFO (zkCallback-320-thread-1-processing-n:127.0.0.1:47538_i%2Fbi) [n:127.0.0.1:47538_i%2Fbi ] o.a.s.c.c.ZkStateReader Updated cluster state version to 5 [junit4] 2> 376723 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[C79B1F20C326140B]) [n:127.0.0.1:54911_i%2Fbi ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2 [junit4] 2> 376723 INFO (TEST-FullSolrC [...truncated too long message...] r.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> 3891118 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[C79B1F20C326140B]-worker) [n:127.0.0.1:32895_xxso c:addReplicaColl s:shard1 r:core_node1 x:addReplicaColl_shard1_replica1] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> Jul 29, 2015 12:38:05 PM 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=LuceneFixedGap), range_facet_l_dv=PostingsFormat(name=LuceneVarGapFixedInterval), _version_=PostingsFormat(name=LuceneFixedGap), multiDefault=PostingsFormat(name=Memory doPackFST= false), a_t=PostingsFormat(name=Memory doPackFST= false), intDefault=PostingsFormat(name=LuceneFixedGap), a_i1=PostingsFormat(name=Memory doPackFST= false), id=PostingsFormat(name=LuceneVarGapFixedInterval), range_facet_i_dv=PostingsFormat(name=Memory doPackFST= false), text=PostingsFormat(name=Asserting), range_facet_l=PostingsFormat(name=Memory doPackFST= false), timestamp=PostingsFormat(name=Memory doPackFST= false)}, docValues:{range_facet_l_dv=DocValuesFormat(name=Memory), range_facet_i_dv=DocValuesFormat(name=Direct), timestamp=DocValuesFormat(name=Direct)}, sim=RandomSimilarityProvider(queryNorm=false,coord=yes): {}, locale=zh, timezone=Europe/Riga [junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.8.0_45 (64-bit)/cpus=4,threads=2,free=128592376,total=532152320 [junit4] 2> NOTE: All tests run in this JVM: [PreAnalyzedFieldTest, FieldMutatingUpdateProcessorTest, JsonLoaderTest, CdcrRequestHandlerTest, TestStressUserVersions, SliceStateTest, OpenCloseCoreStressTest, HdfsThreadLeakTest, DistributedTermsComponentTest, TestStandardQParsers, TestCustomSort, OutOfBoxZkACLAndCredentialsProvidersTest, EnumFieldTest, TestSolrCoreProperties, TestCharFilters, AlternateDirectoryTest, DistributedMLTComponentTest, HLLUtilTest, TestReRankQParserPlugin, ZkCLITest, TestIndexSearcher, TestMacros, EchoParamsTest, TestFreeTextSuggestions, SSLMigrationTest, HdfsNNFailoverTest, TestReplicationHandlerBackup, BufferStoreTest, TestShortCircuitedRequests, AnalysisAfterCoreReloadTest, DistanceFunctionTest, TestImplicitCoreProperties, ZkSolrClientTest, TestIntervalFaceting, TestInitQParser, TestFastWriter, TestSchemaResource, CoreAdminHandlerTest, TestCoreContainer, TestNRTOpen, TestLMDirichletSimilarityFactory, DistributedExpandComponentTest, FullHLLTest, TestHashPartitioner, SimpleMLTQParserTest, TestDistributedStatsComponentCardinality, TestWriterPerf, WordBreakSolrSpellCheckerTest, CurrencyFieldOpenExchangeTest, TestSolrQueryParserResource, BJQParserTest, TestRTGBase, IndexSchemaRuntimeFieldTest, TestFileDictionaryLookup, SharedFSAutoReplicaFailoverUtilsTest, DirectSolrConnectionTest, RAMDirectoryFactoryTest, TestConfigReload, CustomCollectionTest, OverseerRolesTest, ResourceLoaderTest, ConvertedLegacyTest, BadComponentTest, TestDistributedMissingSort, TestOrdValues, BitVectorTest, TestRestManager, LukeRequestHandlerTest, SpatialFilterTest, TestFastLRUCache, SolrCloudExampleTest, SuggestComponentTest, SpellCheckComponentTest, ConnectionManagerTest, CollectionsAPIDistributedZkTest, HdfsChaosMonkeySafeLeaderTest, TestRandomRequestDistribution, FieldAnalysisRequestHandlerTest, FileUtilsTest, ShardSplitTest, TestDistribDocBasedVersion, TestScoreJoinQPScore, FacetPivotSmallTest, HdfsLockFactoryTest, TestManagedSchema, DistribDocExpirationUpdateProcessorTest, TestCryptoKeys, TestSolrCloudWithKerberosAlt, SyncSliceTest, ShardRoutingTest, RecoveryZkTest, ClusterStateUpdateTest, LeaderElectionTest, TestZkChroot, ShardRoutingCustomTest, TestDistributedSearch, TestDistributedGrouping, TestFaceting, DistributedSpellCheckComponentTest, TermVectorComponentDistributedTest, ZkControllerTest, TestStressReorder, TestJoin, TestStressVersions, HardAutoCommitTest, TestRangeQuery, SolrCoreTest, SolrCmdDistributorTest, QueryElevationComponentTest, PeerSyncTest, BadIndexSchemaTest, TestFiltering, TestFunctionQuery, BasicFunctionalityTest, HighlighterTest, SoftAutoCommitTest, ShowFileRequestHandlerTest, DistributedQueryElevationComponentTest, CurrencyFieldXmlFileTest, SolrIndexSplitterTest, TestCoreDiscovery, SignatureUpdateProcessorFactoryTest, TestExtendedDismaxParser, SpellCheckCollatorTest, SolrRequestParserTest, TestFoldingMultitermQuery, SuggesterTSTTest, SuggesterTest, TestTrie, SuggesterWFSTTest, NoCacheHeaderTest, SchemaVersionSpecificBehaviorTest, TestPseudoReturnFields, TestUpdate, TestAtomicUpdateErrorCases, DefaultValueUpdateProcessorTest, StatelessScriptUpdateProcessorFactoryTest, TestRemoteStreaming, DocValuesMultiTest, SolrInfoMBeanTest, DebugComponentTest, CacheHeaderTest, DisMaxRequestHandlerTest, TestQueryUtils, StandardRequestHandlerTest, TestReversedWildcardFilterFactory, DocumentAnalysisRequestHandlerTest, TestOmitPositions, FileBasedSpellCheckerTest, RequestHandlersTest, DocumentBuilderTest, TestValueSourceCache, PathHierarchyTokenizerFactoryTest, MoreLikeThisHandlerTest, RequiredFieldsTest, TestArbitraryIndexDir, FastVectorHighlighterTest, LoggingHandlerTest, SolrPluginUtilsTest, ReturnFieldsTest, UpdateRequestProcessorFactoryTest, JSONWriterTest, QueryParsingTest, TestAnalyzedSuggestions, TestPHPSerializedResponseWriter, PingRequestHandlerTest, CSVRequestHandlerTest, TestComponentsName, SearchHandlerTest, TestBinaryResponseWriter, TestLFUCache, TestSuggestSpellingConverter, DateFieldTest, SpellingQueryConverterTest, DOMUtilTest, TestSolrJ, TestLRUCache, TestUtils, ZkNodePropsTest, SystemInfoHandlerTest, UUIDFieldTest, CursorPagingTest, SolrTestCaseJ4Test, TestHighlightDedupGrouping, TestSimpleTrackingShardHandler, ActionThrottleTest, AliasIntegrationTest, AssignTest, AsyncCallRequestStatusResponseTest, AsyncMigrateRouteKeyTest, CleanupOldIndexTest, CollectionsAPIAsyncDistributedZkTest, DeleteShardTest, DistributedQueueTest, DistributedVersionInfoTest, LeaderInitiatedRecoveryOnCommitTest, OverriddenZkACLAndCredentialsProvidersTest, ReplicationFactorTest, SaslZkACLProviderTest, SolrXmlInZkTest, TestAuthenticationFramework, TestLeaderElectionZkExpiry, TestRequestStatusCollectionAPI, HdfsCollectionsAPIDistributedZkTest] [junit4] Completed [504/528] on J1 in 436.31s, 1 test, 1 error <<< FAILURES! [...truncated 86 lines...] BUILD FAILED /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:724: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:661: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:59: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build.xml:230: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/common-build.xml:518: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:1429: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:984: There were test failures: 528 suites, 2080 tests, 3 errors, 1 failure, 21 ignored (10 assumptions) Total time: 171 minutes 56 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: [email protected] For additional commands, e-mail: [email protected]
