Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-trunk/941/
2 tests failed. FAILED: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test Error Message: Timeout occured while waiting response from server at: http://127.0.0.1:42905 Stack Trace: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:42905 at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:588) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.makeRequest(CollectionsAPIDistributedZkTest.java:382) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testErrorHandling(CollectionsAPIDistributedZkTest.java:459) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test(CollectionsAPIDistributedZkTest.java:169) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:497) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:964) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:939) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at java.lang.Thread.run(Thread.java:745) 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:482) ... 47 more FAILED: org.apache.solr.cloud.OverseerTest.testShardLeaderChange Error Message: Could not register as the leader because creating the ephemeral registration node in ZooKeeper failed Stack Trace: org.apache.solr.common.SolrException: Could not register as the leader because creating the ephemeral registration node in ZooKeeper failed at __randomizedtesting.SeedInfo.seed([D24697AF374A318E:C1510582DD2C47F]:0) at org.apache.solr.cloud.ShardLeaderElectionContextBase.runLeaderProcess(ElectionContext.java:212) at org.apache.solr.cloud.LeaderElector.runIamLeaderProcess(LeaderElector.java:173) at org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:138) at org.apache.solr.cloud.LeaderElector.joinElection(LeaderElector.java:310) at org.apache.solr.cloud.LeaderElector.joinElection(LeaderElector.java:219) at org.apache.solr.cloud.OverseerTest$MockZKController.publishState(OverseerTest.java:181) at org.apache.solr.cloud.OverseerTest.testShardLeaderChange(OverseerTest.java:841) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:497) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at java.lang.Thread.run(Thread.java:745) Caused by: org.apache.zookeeper.KeeperException$NodeExistsException: KeeperErrorCode = NodeExists at org.apache.zookeeper.KeeperException.create(KeeperException.java:119) at org.apache.zookeeper.ZooKeeper.multiInternal(ZooKeeper.java:949) at org.apache.zookeeper.ZooKeeper.multi(ZooKeeper.java:915) at org.apache.solr.common.cloud.SolrZkClient$11.execute(SolrZkClient.java:577) at org.apache.solr.common.cloud.SolrZkClient$11.execute(SolrZkClient.java:574) at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60) at org.apache.solr.common.cloud.SolrZkClient.multi(SolrZkClient.java:574) at org.apache.solr.cloud.ShardLeaderElectionContextBase$1.execute(ElectionContext.java:195) at org.apache.solr.common.util.RetryUtil.retryOnThrowable(RetryUtil.java:49) at org.apache.solr.common.util.RetryUtil.retryOnThrowable(RetryUtil.java:42) at org.apache.solr.cloud.ShardLeaderElectionContextBase.runLeaderProcess(ElectionContext.java:178) ... 45 more Build Log: [...truncated 11701 lines...] [junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/init-core-data-001 [junit4] 2> 1932777 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[D24697AF374A318E]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) [junit4] 2> 1932777 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[D24697AF374A318E]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: / [junit4] 2> 1932781 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 1932781 INFO (Thread-53237) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 1932781 INFO (Thread-53237) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 1932881 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.ZkTestServer start zk server on port:49189 [junit4] 2> 1932882 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1932882 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1932885 INFO (zkCallback-2123-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@74f92795 name:ZooKeeperConnection Watcher:127.0.0.1:49189 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1932885 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1932885 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1932886 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 1932889 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1932890 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1932891 INFO (zkCallback-2124-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6721e307 name:ZooKeeperConnection Watcher:127.0.0.1:49189/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1932891 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1932891 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1932891 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1 [junit4] 2> 1932894 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards [junit4] 2> 1932895 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection [junit4] 2> 1932896 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards [junit4] 2> 1932898 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] 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> 1932898 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml [junit4] 2> 1932900 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml [junit4] 2> 1932901 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml [junit4] 2> 1932903 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] 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> 1932903 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 1932904 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] 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> 1932904 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt [junit4] 2> 1932906 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] 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> 1932906 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt [junit4] 2> 1932908 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] 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> 1932908 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml [junit4] 2> 1932910 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] 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> 1932910 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 1932911 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] 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> 1932912 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 1932913 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] 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> 1932913 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 1932915 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] 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> 1932915 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 1932917 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] 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> 1932917 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt [junit4] 2> 1932919 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1932919 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1932920 INFO (zkCallback-2125-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@68da5aba name:ZooKeeperConnection Watcher:127.0.0.1:49189 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1932920 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1932921 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1932921 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 1932922 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1932922 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1932923 INFO (zkCallback-2126-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@36eb22e8 name:ZooKeeperConnection Watcher:127.0.0.1:49189/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1932923 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1932923 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1932924 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf2/solrconfig.xml [junit4] 2> 1932924 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/solrconfig.xml [junit4] 2> 1932926 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf2/schema.xml [junit4] 2> 1932926 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/schema.xml [junit4] 2> 1932928 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf2/enumsConfig.xml [junit4] 2> 1932928 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/enumsConfig.xml [junit4] 2> 1932930 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf2/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 1932930 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 1932931 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf2/stopwords.txt [junit4] 2> 1932931 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/stopwords.txt [junit4] 2> 1932934 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf2/protwords.txt [junit4] 2> 1932934 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/protwords.txt [junit4] 2> 1932936 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf2/currency.xml [junit4] 2> 1932936 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/currency.xml [junit4] 2> 1932938 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf2/open-exchange-rates.json [junit4] 2> 1932939 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/open-exchange-rates.json [junit4] 2> 1932940 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf2/mapping-ISOLatin1Accent.txt [junit4] 2> 1932940 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/mapping-ISOLatin1Accent.txt [junit4] 2> 1932942 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf2/old_synonyms.txt [junit4] 2> 1932942 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/old_synonyms.txt [junit4] 2> 1932944 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf2/synonyms.txt [junit4] 2> 1932944 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/synonyms.txt [junit4] 2> 1932946 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/elevate.xml to /configs/conf2/elevate.xml [junit4] 2> 1932946 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/elevate.xml [junit4] 2> 1933045 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/control-001/cores/collection1 [junit4] 2> 1933048 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.e.j.s.Server jetty-9.3.6.v20151106 [junit4] 2> 1933050 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@22bd1a42{/,null,AVAILABLE} [junit4] 2> 1933055 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.e.j.s.ServerConnector Started ServerConnector@4556ad17{HTTP/1.1,[http/1.1]}{127.0.0.1:60352} [junit4] 2> 1933055 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.e.j.s.Server Started @1936494ms [junit4] 2> 1933055 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/tempDir-001/control/data, hostContext=/, hostPort=60352, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/control-001/cores} [junit4] 2> 1933055 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a [junit4] 2> 1933056 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/control-001' [junit4] 2> 1933056 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 1933056 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 1933056 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1933057 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1933058 INFO (zkCallback-2127-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@44f0c440 name:ZooKeeperConnection Watcher:127.0.0.1:49189/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1933058 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1933058 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1933059 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 1933059 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/control-001/solr.xml [junit4] 2> 1933064 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/control-001/cores [junit4] 2> 1933064 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.CoreContainer New CoreContainer 1784661764 [junit4] 2> 1933064 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/control-001] [junit4] 2> 1933064 WARN (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/control-001/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/control-001/lib [junit4] 2> 1933065 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] 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> 1933066 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 1933067 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 1933067 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 1933067 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:49189/solr [junit4] 2> 1933067 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 1933067 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1933068 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1933069 INFO (zkCallback-2130-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1f3cae3e name:ZooKeeperConnection Watcher:127.0.0.1:49189 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1933070 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1933070 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1933072 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1933073 INFO (zkCallback-2131-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@399849fd name:ZooKeeperConnection Watcher:127.0.0.1:49189/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1933073 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1933074 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue [junit4] 2> 1933075 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work [junit4] 2> 1933078 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running [junit4] 2> 1933079 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed [junit4] 2> 1933081 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure [junit4] 2> 1933083 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 1933084 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 1933085 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 1933086 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 1933087 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60352_ [junit4] 2> 1933087 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:60352_ [junit4] 2> 1933089 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect [junit4] 2> 1933090 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election [junit4] 2> 1933091 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 1933092 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/95435677921116166-127.0.0.1:60352_-n_0000000000 [junit4] 2> 1933092 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:60352_ [junit4] 2> 1933092 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader [junit4] 2> 1933093 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.Overseer Overseer (id=95435677921116166-127.0.0.1:60352_-n_0000000000) starting [junit4] 2> 1933095 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work [junit4] 2> 1933100 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=10000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 1933101 INFO (OverseerCollectionConfigSetProcessor-95435677921116166-127.0.0.1:60352_-n_0000000000) [n:127.0.0.1:60352_ ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations [junit4] 2> 1933101 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 1933101 INFO (OverseerStateUpdate-95435677921116166-127.0.0.1:60352_-n_0000000000) [n:127.0.0.1:60352_ ] o.a.s.c.Overseer Starting to work on the main queue [junit4] 2> 1933104 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 1933109 INFO (OverseerStateUpdate-95435677921116166-127.0.0.1:60352_-n_0000000000) [n:127.0.0.1:60352_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (1) [junit4] 2> 1933121 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 1933121 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 1933122 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/control-001/cores [junit4] 2> 1933124 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, collection=control_collection, coreNodeName=, dataDir=data/, shard=} [junit4] 2> 1933124 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.CorePropertiesLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/control-001/cores/collection1 [junit4] 2> 1933124 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions [junit4] 2> 1933125 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1 [junit4] 2> 1933125 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [n:127.0.0.1:60352_ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 1933126 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection x:collection1] o.a.s.c.ZkController publishing state=down [junit4] 2> 1933126 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 1933128 INFO (OverseerStateUpdate-95435677921116166-127.0.0.1:60352_-n_0000000000) [n:127.0.0.1:60352_ ] 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:60352";, [junit4] 2> "node_name":"127.0.0.1:60352_", [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> 1933128 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection x:collection1] o.a.s.c.ZkController look for our core node name [junit4] 2> 1933128 INFO (OverseerStateUpdate-95435677921116166-127.0.0.1:60352_-n_0000000000) [n:127.0.0.1:60352_ ] 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:60352";, [junit4] 2> "node_name":"127.0.0.1:60352_", [junit4] 2> "numShards":"1", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 1933129 INFO (OverseerStateUpdate-95435677921116166-127.0.0.1:60352_-n_0000000000) [n:127.0.0.1:60352_ ] o.a.s.c.o.ClusterStateMutator building a new cName: control_collection [junit4] 2> 1933129 INFO (OverseerStateUpdate-95435677921116166-127.0.0.1:60352_-n_0000000000) [n:127.0.0.1:60352_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1 [junit4] 2> 1933130 INFO (zkCallback-2131-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ ] 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> 1934129 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection x:collection1] o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1 [junit4] 2> 1934129 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection x:collection1] o.a.s.c.ZkController Check for collection zkNode:control_collection [junit4] 2> 1934129 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection x:collection1] o.a.s.c.ZkController Collection zkNode exists [junit4] 2> 1934129 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection x:collection1] o.a.s.c.c.ZkStateReader Load collection config from: [/collections/control_collection] [junit4] 2> 1934130 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection x:collection1] o.a.s.c.c.ZkStateReader path=[/collections/control_collection] [configName]=[conf1] specified config exists in ZooKeeper [junit4] 2> 1934130 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection x:collection1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/control-001/cores/collection1' [junit4] 2> 1934130 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection x:collection1] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 1934130 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection x:collection1] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 1934132 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection x:collection1] o.a.s.c.Config loaded config solrconfig.xml with version 0 [junit4] 2> 1934137 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 1934141 WARN (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead. [junit4] 2> 1934141 WARN (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <maxMergeDocs> is deprecated, configure it on the relevant <mergePolicyFactory> instead. [junit4] 2> 1934141 WARN (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergeFactor> is deprecated, configure it on the relevant <mergePolicyFactory> instead. [junit4] 2> 1934142 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0 [junit4] 2> 1934150 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection x:collection1] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml [junit4] 2> 1934156 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1934248 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 1934254 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection x:collection1] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 1934255 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection x:collection1] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 1934263 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 1934265 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 1934268 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1934268 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1934270 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection x:collection1] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/configs/conf1', cwd=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1 [junit4] 2> 1934270 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection control_collection [junit4] 2> 1934270 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 1934270 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/control-001/cores/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/control-001/cores/collection1/data/] [junit4] 2> 1934270 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ 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@324966a3 [junit4] 2> 1934271 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/control-001/cores/collection1/data [junit4] 2> 1934271 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/control-001/cores/collection1/data/index/ [junit4] 2> 1934271 WARN (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/control-001/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 1934271 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/control-001/cores/collection1/data/index [junit4] 2> 1934272 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1953717761, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1] [junit4] 2> 1934272 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@301b543f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7e982d30),segFN=segments_1,generation=1} [junit4] 2> 1934272 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 1934273 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/control-001/cores/collection1/data/ [junit4] 2> 1934273 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.DirectoryFactory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/control-001/cores/collection1/data/ does not point to a valid data directory; skipping clean-up of old index directories. [junit4] 2> 1934276 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "nodistrib" [junit4] 2> 1934276 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe" [junit4] 2> 1934277 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 1934277 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig" [junit4] 2> 1934277 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 1934277 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ 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> 1934277 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ 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> 1934277 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ 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> 1934277 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ 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> 1934277 WARN (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,args = {defaults={a=A,b=B}}} [junit4] 2> 1934279 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1934280 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1934281 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1934282 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1934285 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,/dump,/update/csv,/sql,/update/json/docs,/admin/luke,/export,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/stream,/schema,/admin/plugins,/admin/logging,/update/json,/admin/ping,/admin/threads,/update,/admin/file [junit4] 2> 1934285 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ 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> 1934286 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ 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> 1934286 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ 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> 1934286 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1934287 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1934287 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=418290869, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1] [junit4] 2> 1934287 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@301b543f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7e982d30),segFN=segments_1,generation=1} [junit4] 2> 1934287 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 1934287 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1d873664[collection1] main] [junit4] 2> 1934288 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ 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> 1934288 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ 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> 1934288 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ 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> 1934289 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 1934289 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {} [junit4] 2> 1934289 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ 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> 1934289 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ 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> 1934289 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ 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> 1934289 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 1934289 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1934290 INFO (searcherExecutor-5889-thread-1-processing-n:127.0.0.1:60352_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1d873664[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1934290 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ 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> 1934290 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ 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> 1934290 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ 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> 1934290 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ 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 1526970848318062592 [junit4] 2> 1934292 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Took 2.0ms to seed version buckets with highest version 1526970848318062592 [junit4] 2> 1934292 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1 [junit4] 2> 1934293 INFO (coreLoadExecutor-5888-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 1934293 INFO (coreZkRegister-5882-thread-1-processing-n:127.0.0.1:60352_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60352_ 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:60352 collection:control_collection shard:shard1 [junit4] 2> 1934294 INFO (coreZkRegister-5882-thread-1-processing-n:127.0.0.1:60352_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60352_ 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> 1934298 INFO (coreZkRegister-5882-thread-1-processing-n:127.0.0.1:60352_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60352_ 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/95435677921116166-core_node1-n_0000000000 [junit4] 2> 1934298 INFO (coreZkRegister-5882-thread-1-processing-n:127.0.0.1:60352_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Running the leader process for shard=shard1 and weAreReplacement=false and leaderVoteWait=180000 [junit4] 2> 1934300 INFO (coreZkRegister-5882-thread-1-processing-n:127.0.0.1:60352_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 1934300 INFO (coreZkRegister-5882-thread-1-processing-n:127.0.0.1:60352_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60352_ 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> 1934300 INFO (coreZkRegister-5882-thread-1-processing-n:127.0.0.1:60352_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:60352/collection1/ [junit4] 2> 1934300 INFO (coreZkRegister-5882-thread-1-processing-n:127.0.0.1:60352_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 1934300 INFO (coreZkRegister-5882-thread-1-processing-n:127.0.0.1:60352_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:60352/collection1/ has no replicas [junit4] 2> 1934300 INFO (OverseerStateUpdate-95435677921116166-127.0.0.1:60352_-n_0000000000) [n:127.0.0.1:60352_ ] 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> 1934301 INFO (coreZkRegister-5882-thread-1-processing-n:127.0.0.1:60352_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1 [junit4] 2> 1934304 INFO (coreZkRegister-5882-thread-1-processing-n:127.0.0.1:60352_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/control_collection/leaders/shard1/leader after winning as /collections/control_collection/leader_elect/shard1/election/95435677921116166-core_node1-n_0000000000 [junit4] 2> 1934305 INFO (coreZkRegister-5882-thread-1-processing-n:127.0.0.1:60352_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60352_ 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:60352/collection1/ shard1 [junit4] 2> 1934306 INFO (OverseerStateUpdate-95435677921116166-127.0.0.1:60352_-n_0000000000) [n:127.0.0.1:60352_ ] 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:60352";, [junit4] 2> "core":"collection1", [junit4] 2> "state":"active"} current state version: 1 [junit4] 2> 1934408 INFO (zkCallback-2131-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ ] 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> 1934457 INFO (coreZkRegister-5882-thread-1-processing-n:127.0.0.1:60352_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController We are http://127.0.0.1:60352/collection1/ and leader is http://127.0.0.1:60352/collection1/ [junit4] 2> 1934457 INFO (coreZkRegister-5882-thread-1-processing-n:127.0.0.1:60352_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60352_ 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:60352 [junit4] 2> 1934457 INFO (coreZkRegister-5882-thread-1-processing-n:127.0.0.1:60352_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 1934457 INFO (coreZkRegister-5882-thread-1-processing-n:127.0.0.1:60352_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController publishing state=active [junit4] 2> 1934457 INFO (coreZkRegister-5882-thread-1-processing-n:127.0.0.1:60352_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60352_ 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> 1934459 INFO (OverseerStateUpdate-95435677921116166-127.0.0.1:60352_-n_0000000000) [n:127.0.0.1:60352_ ] 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:60352";, [junit4] 2> "node_name":"127.0.0.1:60352_", [junit4] 2> "numShards":"1", [junit4] 2> "state":"active", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} current state version: 2 [junit4] 2> 1934459 INFO (coreZkRegister-5882-thread-1-processing-n:127.0.0.1:60352_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:60352_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (1) [junit4] 2> 1934459 INFO (OverseerStateUpdate-95435677921116166-127.0.0.1:60352_-n_0000000000) [n:127.0.0.1:60352_ ] 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:60352";, [junit4] 2> "node_name":"127.0.0.1:60352_", [junit4] 2> "numShards":"1", [junit4] 2> "state":"active", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 1934562 INFO (zkCallback-2131-thread-1-processing-n:127.0.0.1:60352_) [n:127.0.0.1:60352_ ] 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> 1934627 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1934628 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1934629 INFO (zkCallback-2133-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6c4e4882 name:ZooKeeperConnection Watcher:127.0.0.1:49189/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1934629 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1934629 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1934629 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 1934630 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 1934631 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false [junit4] 2> 1934631 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with stateFormat=2 [junit4] 2> 1934631 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1934631 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1934632 INFO (zkCallback-2134-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@44010f00 name:ZooKeeperConnection Watcher:127.0.0.1:49189/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1934632 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1934633 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1934635 INFO (OverseerStateUpdate-95435677921116166-127.0.0.1:60352_-n_0000000000) [n:127.0.0.1:60352_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"create", [junit4] 2> "name":"collection1", [junit4] 2> "numShards":"2", [junit4] 2> "stateFormat":"2"} current state version: 3 [junit4] 2> 1934635 INFO (OverseerStateUpdate-95435677921116166-127.0.0.1:60352_-n_0000000000) [n:127.0.0.1:60352_ ] o.a.s.c.o.ClusterStateMutator building a new cName: collection1 [junit4] 2> 1934732 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/shard-1-001/cores/collection1 [junit4] 2> 1934733 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/shard-1-001 [junit4] 2> 1934734 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.e.j.s.Server jetty-9.3.6.v20151106 [junit4] 2> 1934735 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@609d0b41{/,null,AVAILABLE} [junit4] 2> 1934736 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.e.j.s.ServerConnector Started ServerConnector@7043d562{HTTP/1.1,[http/1.1]}{127.0.0.1:42905} [junit4] 2> 1934736 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.e.j.s.Server Started @1938175ms [junit4] 2> 1934737 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/tempDir-001/jetty1, solrconfig=solrconfig.xml, hostContext=/, hostPort=42905, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/shard-1-001/cores} [junit4] 2> 1934737 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a [junit4] 2> 1934737 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/shard-1-001' [junit4] 2> 1934737 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 1934737 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 1934738 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1934738 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1934739 INFO (zkCallback-2135-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4fc59f13 name:ZooKeeperConnection Watcher:127.0.0.1:49189/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1934739 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1934739 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1934740 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 1934740 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/shard-1-001/solr.xml [junit4] 2> 1934741 INFO (OverseerStateUpdate-95435677921116166-127.0.0.1:60352_-n_0000000000) [n:127.0.0.1:60352_ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/collection1/state.json [junit4] 2> 1934745 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/shard-1-001/cores [junit4] 2> 1934745 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.CoreContainer New CoreContainer 1860862635 [junit4] 2> 1934745 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/shard-1-001] [junit4] 2> 1934746 WARN (TEST-CollectionsAPIDistributedZkTest.test-seed#[D24697AF374A318E]) [ ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D24697AF374A318E-001/shard-1-001/l [...truncated too long message...] n], has occurred - updating... (live nodes size: [0]) [junit4] 2> 2740877 INFO (OverseerStateUpdate-95435730840125443-127.0.0.1:57482_solr-n_0000000000) [ ] o.a.s.c.Overseer processMessage: queueSize: 0, message = { [junit4] 2> "operation":"create", [junit4] 2> "name":"test", [junit4] 2> "numShards":"1", [junit4] 2> "replicationFactor":"1", [junit4] 2> "stateFormat":"2"} current state version: 4 [junit4] 2> 2740877 INFO (OverseerStateUpdate-95435730840125443-127.0.0.1:57482_solr-n_0000000000) [ ] o.a.s.c.o.ClusterStateMutator building a new cName: test [junit4] 2> 2740881 INFO (OverseerStateUpdate-95435730840125443-127.0.0.1:57482_solr-n_0000000000) [ ] o.a.s.c.Overseer processMessage: queueSize: 0, message = { [junit4] 2> "operation":"createshard", [junit4] 2> "collection":"test", [junit4] 2> "shard":"x", [junit4] 2> "replicationFactor":"1"} current state version: 4 [junit4] 2> 2740883 INFO (OverseerStateUpdate-95435730840125443-127.0.0.1:57482_solr-n_0000000000) [ ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"addreplica", [junit4] 2> "collection":"test", [junit4] 2> "shard":"x", [junit4] 2> "base_url":"http://127.0.0.1/solr";, [junit4] 2> "node_name":"node1", [junit4] 2> "core":"core1", [junit4] 2> "state":"down"} current state version: 4 [junit4] 2> 2740884 INFO (OverseerStateUpdate-95435730840125443-127.0.0.1:57482_solr-n_0000000000) [ ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"addreplica", [junit4] 2> "collection":"test", [junit4] 2> "shard":"x", [junit4] 2> "base_url":"http://127.0.0.1/solr";, [junit4] 2> "node_name":"node1", [junit4] 2> "core":"core1", [junit4] 2> "state":"down"} [junit4] 2> 2740911 INFO (TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 2740963 INFO (TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 2740989 INFO (OverseerStateUpdate-95435730840125443-127.0.0.1:57482_solr-n_0000000000) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/test/state.json [junit4] 2> 2741017 INFO (TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 2741019 INFO (TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[D24697AF374A318E]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 2741023 INFO (TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[D24697AF374A318E]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:57482 57482 [junit4] 2> 2741167 INFO (Thread-53885) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:57482 57482 [junit4] 2> 2741168 WARN (Thread-53885) [ ] o.a.s.c.ZkTestServer Watch limit violations: [junit4] 2> Maximum concurrent create/delete watches above limit: [junit4] 2> [junit4] 2> 2 /solr/aliases.json [junit4] 2> [junit4] 2> Maximum concurrent data watches above limit: [junit4] 2> [junit4] 2> 2 /solr/clusterstate.json [junit4] 2> [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2> [junit4] 2> 2 /solr/live_nodes [junit4] 2> 2 /solr/collections [junit4] 2> [junit4] 2> 2741168 INFO (TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[D24697AF374A318E]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalClusterStateChangeBehavior [junit4] 2> 2741168 INFO (TEST-OverseerTest.testExternalClusterStateChangeBehavior-seed#[D24697AF374A318E]) [ ] o.a.s.c.Overseer Overseer (id=95435730840125443-127.0.0.1:57482_solr-n_0000000000) closing [junit4] 2> 2741168 INFO (OverseerStateUpdate-95435730840125443-127.0.0.1:57482_solr-n_0000000000) [ ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:57482_solr [junit4] 2> 2741169 ERROR (OverseerExitThread) [ ] o.a.s.c.Overseer could not read the data [junit4] 2> org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /overseer_elect/leader [junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:127) [junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:51) [junit4] 2> at org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:1155) [junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:353) [junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:350) [junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60) [junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:350) [junit4] 2> at org.apache.solr.cloud.Overseer$ClusterStateUpdater.checkIfIamStillLeader(Overseer.java:308) [junit4] 2> at org.apache.solr.cloud.Overseer$ClusterStateUpdater.access$300(Overseer.java:89) [junit4] 2> at org.apache.solr.cloud.Overseer$ClusterStateUpdater$2.run(Overseer.java:267) [junit4] 2> 2744170 INFO (SUITE-OverseerTest-seed#[D24697AF374A318E]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.OverseerTest_D24697AF374A318E-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene60): {}, docValues:{}, sim=RandomSimilarity(queryNorm=true,coord=yes): {}, locale=ar-BH, timezone=America/North_Dakota/New_Salem [junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.8.0_66 (64-bit)/cpus=4,threads=1,free=284915400,total=499646464 [junit4] 2> NOTE: All tests run in this JVM: [TestRestManager, TestReversedWildcardFilterFactory, BadIndexSchemaTest, FieldAnalysisRequestHandlerTest, TestSolrDeletionPolicy1, ExitableDirectoryReaderTest, CursorMarkTest, TestConfigSetsAPIExclusivity, StatsComponentTest, HdfsTlogReplayBufferedWhileIndexingTest, DistribCursorPagingTest, TestWriterPerf, SuggestComponentTest, TestPivotHelperCode, TestPerFieldSimilarityClassic, TestSweetSpotSimilarityFactory, SuggesterWFSTTest, TestReqParamsAPI, BlockCacheTest, ShowFileRequestHandlerTest, VersionInfoTest, DocValuesMultiTest, HLLUtilTest, TestFuzzyAnalyzedSuggestions, TestDocBasedVersionConstraints, TestDefaultStatsCache, StressHdfsTest, TestDynamicFieldResource, TestSchemaVersionResource, LeaderInitiatedRecoveryOnShardRestartTest, BasicDistributedZk2Test, TestSortingResponseWriter, TestStandardQParsers, TestPHPSerializedResponseWriter, RecoveryZkTest, TestClassicSimilarityFactory, TestCoreDiscovery, TestCopyFieldCollectionResource, TestNoOpRegenerator, CoreAdminHandlerTest, SampleTest, TestDistribDocBasedVersion, RegexBoostProcessorTest, ConcurrentDeleteAndCreateCollectionTest, VMParamsZkACLAndCredentialsProvidersTest, UUIDUpdateProcessorFallbackTest, TestInitQParser, TestRequestForwarding, TestPostingsSolrHighlighter, TestSimpleQParserPlugin, ConjunctionSolrSpellCheckerTest, RulesTest, TestSolrConfigHandlerCloud, ScriptEngineTest, AnalysisErrorHandlingTest, BaseCdcrDistributedZkTest, RequestHandlersTest, CurrencyFieldXmlFileTest, TestCSVResponseWriter, PrimitiveFieldTypeTest, TestSolrIndexConfig, TestSuggestSpellingConverter, DistributedQueryComponentCustomSortTest, SecurityConfHandlerTest, XmlUpdateRequestHandlerTest, TestElisionMultitermQuery, AutoCommitTest, ClusterStateTest, TestXmlQParser, TestUtils, HighlighterConfigTest, HttpPartitionTest, TestJettySolrRunner, UpdateParamsTest, ParsingFieldUpdateProcessorsTest, ExplicitHLLTest, TestSearchPerf, BlockJoinFacetDistribTest, TestDistributedMissingSort, SuggesterTSTTest, QueryParsingTest, TestSolrJ, TestRTimerTree, TestZkChroot, TestCharFilters, RestartWhileUpdatingTest, TestRecoveryHdfs, DateRangeFieldTest, StatelessScriptUpdateProcessorFactoryTest, SpatialRPTFieldTypeTest, HdfsNNFailoverTest, HdfsChaosMonkeyNothingIsSafeTest, PluginInfoTest, PKIAuthenticationIntegrationTest, OpenCloseCoreStressTest, OverseerTest] [junit4] Completed [283/580 (2!)] on J2 in 135.36s, 13 tests, 1 error, 1 skipped <<< FAILURES! [...truncated 958 lines...] BUILD FAILED /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:747: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:684: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:59: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build.xml:233: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/common-build.xml:524: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:1457: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:1014: There were test failures: 580 suites (8 ignored), 2345 tests, 2 errors, 33 ignored (17 assumptions) [seed: D24697AF374A318E] Total time: 218 minutes 49 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts No prior successful build to compare, so performing full copy of artifacts Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org
