Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-6.x/118/
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:41908 Stack Trace: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:41908 at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:601) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:259) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.makeRequest(CollectionsAPIDistributedZkTest.java:399) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testErrorHandling(CollectionsAPIDistributedZkTest.java:515) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test(CollectionsAPIDistributedZkTest.java:179) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java: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:992) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967) 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:495) ... 47 more FAILED: org.apache.solr.cloud.FullSolrCloudDistribCmdsTest.test Error Message: Captured an uncaught exception in thread: Thread[id=9162, name=Thread-5145, state=RUNNABLE, group=TGRP-FullSolrCloudDistribCmdsTest] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=9162, name=Thread-5145, state=RUNNABLE, group=TGRP-FullSolrCloudDistribCmdsTest] Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:37371/_/u/collection1 at __randomizedtesting.SeedInfo.seed([EB0F404E15FE48A1]:0) at org.apache.solr.cloud.FullSolrCloudDistribCmdsTest$1IndexThread.run(FullSolrCloudDistribCmdsTest.java:644) Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:37371/_/u/collection1 at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:601) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:259) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:149) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:166) at org.apache.solr.cloud.FullSolrCloudDistribCmdsTest$1IndexThread.run(FullSolrCloudDistribCmdsTest.java:642) 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:495) ... 5 more Build Log: [...truncated 11587 lines...] [junit4] Suite: org.apache.solr.cloud.FullSolrCloudDistribCmdsTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/init-core-data-001 [junit4] 2> 811583 INFO (SUITE-FullSolrCloudDistribCmdsTest-seed#[EB0F404E15FE48A1]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-5776) [junit4] 2> 811583 INFO (SUITE-FullSolrCloudDistribCmdsTest-seed#[EB0F404E15FE48A1]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /_/u [junit4] 2> 811585 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 811585 INFO (Thread-5033) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 811585 INFO (Thread-5033) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 811685 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.ZkTestServer start zk server on port:35884 [junit4] 2> 811685 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 811686 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 811690 INFO (zkCallback-869-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@611f75c4 name:ZooKeeperConnection Watcher:127.0.0.1:35884 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 811690 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 811690 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 811690 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 811692 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 811693 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 811694 INFO (zkCallback-870-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6ccb662e name:ZooKeeperConnection Watcher:127.0.0.1:35884/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 811694 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 811695 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 811695 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1 [junit4] 2> 811698 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards [junit4] 2> 811699 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection [junit4] 2> 811699 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards [junit4] 2> 811702 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml [junit4] 2> 811702 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml [junit4] 2> 811704 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/schema15.xml to /configs/conf1/schema.xml [junit4] 2> 811704 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml [junit4] 2> 811705 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 811705 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 811707 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt [junit4] 2> 811707 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt [junit4] 2> 811708 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt [junit4] 2> 811708 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt [junit4] 2> 811709 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml [junit4] 2> 811709 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml [junit4] 2> 811710 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml [junit4] 2> 811710 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 811711 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json [junit4] 2> 811711 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 811717 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 811717 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 811718 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt [junit4] 2> 811718 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 811719 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt [junit4] 2> 811719 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt [junit4] 2> 811807 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/control-001/cores/collection1 [junit4] 2> 811809 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314 [junit4] 2> 811810 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@293e8021{/_/u,null,AVAILABLE} [junit4] 2> 811816 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.e.j.s.ServerConnector Started ServerConnector@71ef2cd2{HTTP/1.1,[http/1.1]}{127.0.0.1:?????} [junit4] 2> 811817 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.e.j.s.Server Started @??????ms [junit4] 2> 811817 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/tempDir-001/control/data, hostContext=/_/u, hostPort=37371, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/control-001/cores} [junit4] 2> 811817 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@73d16e93 [junit4] 2> 811818 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/control-001' [junit4] 2> 811818 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 811818 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 811818 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 811821 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 811825 INFO (zkCallback-871-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6e2d9b81 name:ZooKeeperConnection Watcher:127.0.0.1:35884/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 811825 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 811825 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 811829 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 811829 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/control-001/solr.xml [junit4] 2> 811834 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/control-001/cores [junit4] 2> 811835 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.CoreContainer New CoreContainer 1323295461 [junit4] 2> 811835 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/control-001] [junit4] 2> 811835 WARN (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/control-001/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/control-001/lib [junit4] 2> 811835 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] 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> 811836 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 811836 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 811837 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 811837 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35884/solr [junit4] 2> 811837 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 811837 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 811841 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 811856 INFO (zkCallback-874-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@512aaf13 name:ZooKeeperConnection Watcher:127.0.0.1:35884 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 811857 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 811857 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 811859 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.ZkController Added new OnReconnect listener org.apache.solr.cloud.ZkController$$Lambda$76/406709333@38da9d1e [junit4] 2> 811863 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 811864 INFO (zkCallback-875-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3725ec51 name:ZooKeeperConnection Watcher:127.0.0.1:35884/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 811864 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 811865 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue [junit4] 2> 811866 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work [junit4] 2> 811868 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running [junit4] 2> 811869 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed [junit4] 2> 811871 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure [junit4] 2> 811872 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 811873 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 811874 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 811875 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 811876 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 811876 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties [junit4] 2> 811877 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 811878 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect [junit4] 2> 811879 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election [junit4] 2> 811880 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 811896 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/96232419900129284-127.0.0.1:37371__%2Fu-n_0000000000 [junit4] 2> 811898 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:37371__%2Fu [junit4] 2> 811898 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader [junit4] 2> 811905 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.Overseer Overseer (id=96232419900129284-127.0.0.1:37371__%2Fu-n_0000000000) starting [junit4] 2> 811906 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work [junit4] 2> 811911 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=10000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 811914 INFO (OverseerStateUpdate-96232419900129284-127.0.0.1:37371__%2Fu-n_0000000000) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.Overseer Starting to work on the main queue [junit4] 2> 811918 INFO (OverseerCollectionConfigSetProcessor-96232419900129284-127.0.0.1:37371__%2Fu-n_0000000000) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations [junit4] 2> 811919 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:37371__%2Fu [junit4] 2> 811919 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:37371__%2Fu [junit4] 2> 811920 INFO (OverseerStateUpdate-96232419900129284-127.0.0.1:37371__%2Fu-n_0000000000) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 811921 INFO (zkCallback-875-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [0]) [junit4] 2> 811922 INFO (zkCallback-875-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 811935 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 811935 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 811936 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/control-001/cores [junit4] 2> 811937 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] 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> 811937 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.CorePropertiesLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/control-001/cores/collection1 [junit4] 2> 811937 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.CorePropertiesLocator Found 1 core definitions [junit4] 2> 811938 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection x:collection1] o.a.s.c.ZkController publishing state=down [junit4] 2> 811938 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 811939 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection x:collection1] o.a.s.c.ZkController Collection control_collection not visible yet, but flagging it so a watch is registered when it becomes visible [junit4] 2> 811940 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection x:collection1] o.a.s.c.c.ZkStateReader Deleting data for [control_collection] [junit4] 2> 811944 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2 [junit4] 2> 811944 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:37371__%2Fu ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 811945 INFO (OverseerStateUpdate-96232419900129284-127.0.0.1:37371__%2Fu-n_0000000000) [n:127.0.0.1:37371__%2Fu ] 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:37371/_/u";, [junit4] 2> "node_name":"127.0.0.1:37371__%2Fu", [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> 811945 INFO (OverseerStateUpdate-96232419900129284-127.0.0.1:37371__%2Fu-n_0000000000) [n:127.0.0.1:37371__%2Fu ] 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:37371/_/u";, [junit4] 2> "node_name":"127.0.0.1:37371__%2Fu", [junit4] 2> "numShards":"1", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 811945 INFO (OverseerStateUpdate-96232419900129284-127.0.0.1:37371__%2Fu-n_0000000000) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.o.ClusterStateMutator building a new cName: control_collection [junit4] 2> 811945 INFO (OverseerStateUpdate-96232419900129284-127.0.0.1:37371__%2Fu-n_0000000000) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1 [junit4] 2> 811947 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection x:collection1] o.a.s.c.ZkController look for our core node name [junit4] 2> 811947 INFO (zkCallback-875-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu ] 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> 812947 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection x:collection1] o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1 [junit4] 2> 812947 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection x:collection1] o.a.s.c.ZkController Check for collection zkNode:control_collection [junit4] 2> 812948 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection x:collection1] o.a.s.c.ZkController Collection zkNode exists [junit4] 2> 812948 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection x:collection1] o.a.s.c.c.ZkStateReader Load collection config from: [/collections/control_collection] [junit4] 2> 812949 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection x:collection1] o.a.s.c.c.ZkStateReader path=[/collections/control_collection] [configName]=[conf1] specified config exists in ZooKeeper [junit4] 2> 812949 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection x:collection1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/control-001/cores/collection1' [junit4] 2> 812949 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection x:collection1] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 812949 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection x:collection1] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 812950 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection x:collection1] o.a.s.c.Config loaded config solrconfig.xml with version 0 [junit4] 2> 812964 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 812970 WARN (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead. [junit4] 2> 812971 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.2.0 [junit4] 2> 812979 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection x:collection1] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml [junit4] 2> 812999 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 813088 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection x:collection1] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 813089 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection x:collection1] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 813089 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 813093 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 813111 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu 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-6.x/solr/build/solr-core/test/J2 [junit4] 2> 813111 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection control_collection [junit4] 2> 813111 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 813111 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu 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-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/control-001/cores/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/control-001/cores/collection1/data/] [junit4] 2> 813111 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu 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@7669aa17 [junit4] 2> 813112 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu 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-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/control-001/cores/collection1/data [junit4] 2> 813113 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu 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-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/control-001/cores/collection1/data/index/ [junit4] 2> 813113 WARN (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu 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-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/control-001/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 813113 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu 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-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/control-001/cores/collection1/data/index [junit4] 2> 813114 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@20d4a1dc [junit4] 2> 813116 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu 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(NIOFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/index-NIOFSDirectory-001 lockFactory=org.apache.lucene.store.NativeFSLockFactory@53a8fddf),segFN=segments_1,generation=1} [junit4] 2> 813116 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 813119 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "nodistrib" [junit4] 2> 813119 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe" [junit4] 2> 813119 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 813119 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig" [junit4] 2> 813119 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 813120 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu 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> 813120 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu 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> 813120 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu 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> 813120 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu 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> 813120 WARN (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu 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> 813122 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 813123 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 813123 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 813124 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 813133 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:37371__%2Fu 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-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/control-001/cores/collection1/data/ [junit4] 2> 813134 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.DirectoryFactory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/control-001/cores/collection1/data/ does not point to a valid data directory; skipping clean-up of old index directories. [junit4] 2> 813135 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/dump,/update/csv,/sql,/graph,/admin/segments,/admin/system,/replication,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file,/terms [junit4] 2> 813135 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu 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> 813136 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu 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> 813136 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu 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> 813137 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 813137 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 813137 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=19, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 813138 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu 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(NIOFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/index-NIOFSDirectory-001 lockFactory=org.apache.lucene.store.NativeFSLockFactory@53a8fddf),segFN=segments_1,generation=1} [junit4] 2> 813139 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 813139 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5cd8b15d[collection1] main] [junit4] 2> 813139 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu 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> 813140 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu 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> 813140 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu 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> 813140 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 813140 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {} [junit4] 2> 813140 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu 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> 813140 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu 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> 813140 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu 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> 813140 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 813141 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 813141 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu 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> 813141 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu 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> 813141 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu 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> 813141 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu 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 1539718720032604160 [junit4] 2> 813143 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Took 1.0ms to seed version buckets with highest version 1539718720032604160 [junit4] 2> 813143 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1 [junit4] 2> 813143 INFO (coreLoadExecutor-2180-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 813144 INFO (searcherExecutor-2181-thread-1-processing-n:127.0.0.1:37371__%2Fu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5cd8b15d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 813144 INFO (coreZkRegister-2174-thread-1-processing-n:127.0.0.1:37371__%2Fu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37371__%2Fu 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:37371/_/u collection:control_collection shard:shard1 [junit4] 2> 813145 INFO (coreZkRegister-2174-thread-1-processing-n:127.0.0.1:37371__%2Fu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37371__%2Fu 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> 813147 INFO (coreZkRegister-2174-thread-1-processing-n:127.0.0.1:37371__%2Fu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37371__%2Fu 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/96232419900129284-core_node1-n_0000000000 [junit4] 2> 813148 INFO (coreZkRegister-2174-thread-1-processing-n:127.0.0.1:37371__%2Fu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37371__%2Fu 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=10000 [junit4] 2> 813149 INFO (coreZkRegister-2174-thread-1-processing-n:127.0.0.1:37371__%2Fu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 813154 INFO (coreZkRegister-2174-thread-1-processing-n:127.0.0.1:37371__%2Fu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37371__%2Fu 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> 813149 INFO (OverseerStateUpdate-96232419900129284-127.0.0.1:37371__%2Fu-n_0000000000) [n:127.0.0.1:37371__%2Fu ] 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> 813154 INFO (coreZkRegister-2174-thread-1-processing-n:127.0.0.1:37371__%2Fu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:37371/_/u/collection1/ [junit4] 2> 813154 INFO (coreZkRegister-2174-thread-1-processing-n:127.0.0.1:37371__%2Fu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 813154 INFO (coreZkRegister-2174-thread-1-processing-n:127.0.0.1:37371__%2Fu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:37371/_/u/collection1/ has no replicas [junit4] 2> 813155 INFO (coreZkRegister-2174-thread-1-processing-n:127.0.0.1:37371__%2Fu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1 [junit4] 2> 813158 INFO (coreZkRegister-2174-thread-1-processing-n:127.0.0.1:37371__%2Fu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37371__%2Fu 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/96232419900129284-core_node1-n_0000000000 [junit4] 2> 813159 INFO (coreZkRegister-2174-thread-1-processing-n:127.0.0.1:37371__%2Fu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37371__%2Fu 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:37371/_/u/collection1/ shard1 [junit4] 2> 813160 INFO (OverseerStateUpdate-96232419900129284-127.0.0.1:37371__%2Fu-n_0000000000) [n:127.0.0.1:37371__%2Fu ] 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:37371/_/u";, [junit4] 2> "core":"collection1", [junit4] 2> "state":"active"} current state version: 1 [junit4] 2> 813262 INFO (zkCallback-875-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu ] 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> 813310 INFO (coreZkRegister-2174-thread-1-processing-n:127.0.0.1:37371__%2Fu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController We are http://127.0.0.1:37371/_/u/collection1/ and leader is http://127.0.0.1:37371/_/u/collection1/ [junit4] 2> 813310 INFO (coreZkRegister-2174-thread-1-processing-n:127.0.0.1:37371__%2Fu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37371__%2Fu 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:37371/_/u [junit4] 2> 813311 INFO (coreZkRegister-2174-thread-1-processing-n:127.0.0.1:37371__%2Fu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 813311 INFO (coreZkRegister-2174-thread-1-processing-n:127.0.0.1:37371__%2Fu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController publishing state=active [junit4] 2> 813311 INFO (coreZkRegister-2174-thread-1-processing-n:127.0.0.1:37371__%2Fu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37371__%2Fu 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> 813312 INFO (coreZkRegister-2174-thread-1-processing-n:127.0.0.1:37371__%2Fu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:37371__%2Fu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.ZkStateReader Checking legacy cluster state for collection control_collection [junit4] 2> 813312 INFO (OverseerStateUpdate-96232419900129284-127.0.0.1:37371__%2Fu-n_0000000000) [n:127.0.0.1:37371__%2Fu ] 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:37371/_/u";, [junit4] 2> "node_name":"127.0.0.1:37371__%2Fu", [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> 813312 INFO (OverseerStateUpdate-96232419900129284-127.0.0.1:37371__%2Fu-n_0000000000) [n:127.0.0.1:37371__%2Fu ] 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:37371/_/u";, [junit4] 2> "node_name":"127.0.0.1:37371__%2Fu", [junit4] 2> "numShards":"1", [junit4] 2> "state":"active", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 813415 INFO (zkCallback-875-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu ] 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> 813446 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 813446 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 813448 INFO (zkCallback-879-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7834760e name:ZooKeeperConnection Watcher:127.0.0.1:35884/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 813448 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 813448 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 813448 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 813449 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties [junit4] 2> 813450 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 813451 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false [junit4] 2> 813451 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with stateFormat=2 [junit4] 2> 813451 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 813463 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 813463 INFO (zkCallback-880-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@72749275 name:ZooKeeperConnection Watcher:127.0.0.1:35884/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 813463 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 813464 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 813465 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x155e2e044060006, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> 813466 INFO (OverseerStateUpdate-96232419900129284-127.0.0.1:37371__%2Fu-n_0000000000) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"create", [junit4] 2> "name":"collection1", [junit4] 2> "numShards":"3", [junit4] 2> "stateFormat":"2"} current state version: 3 [junit4] 2> 813466 INFO (OverseerStateUpdate-96232419900129284-127.0.0.1:37371__%2Fu-n_0000000000) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.o.ClusterStateMutator building a new cName: collection1 [junit4] 2> 813553 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/shard-1-001/cores/collection1 [junit4] 2> 813554 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/shard-1-001 [junit4] 2> 813554 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314 [junit4] 2> 813556 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@763865e6{/_/u,null,AVAILABLE} [junit4] 2> 813556 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.e.j.s.ServerConnector Started ServerConnector@359bd680{HTTP/1.1,[http/1.1]}{127.0.0.1:?????} [junit4] 2> 813557 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.e.j.s.Server Started @??????ms [junit4] 2> 813557 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/tempDir-001/jetty1, solrconfig=solrconfig.xml, hostContext=/_/u, hostPort=44271, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/shard-1-001/cores} [junit4] 2> 813557 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@73d16e93 [junit4] 2> 813557 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/shard-1-001' [junit4] 2> 813558 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 813558 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 813558 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 813558 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 813559 INFO (zkCallback-881-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6a4ba212 name:ZooKeeperConnection Watcher:127.0.0.1:35884/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 813559 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 813560 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 813560 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 813560 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/shard-1-001/solr.xml [junit4] 2> 813566 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/shard-1-001/cores [junit4] 2> 813566 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.CoreContainer New CoreContainer 1821076393 [junit4] 2> 813566 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/shard-1-001] [junit4] 2> 813566 WARN (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/shard-1-001/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_EB0F404E15FE48A1-001/shard-1-001/lib [junit4] 2> 813566 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] 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> 813567 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 813567 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 813567 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 813568 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35884/solr [junit4] 2> 813568 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 813568 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 813568 INFO (OverseerStateUpdate-96232419900129284-127.0.0.1:37371__%2Fu-n_0000000000) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/collection1/state.json [junit4] 2> 813570 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 813571 INFO (zkCallback-884-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@23e99cb2 name:ZooKeeperConnection Watcher:127.0.0.1:35884 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 813571 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 813572 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 813572 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:44271__%2Fu ] o.a.s.c.ZkController Added new OnReconnect listener org.apache.solr.cloud.ZkController$$Lambda$76/406709333@1bb1cb9c [junit4] 2> 813573 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:44271__%2Fu ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 813574 INFO (zkCallback-885-thread-1-processing-n:127.0.0.1:44271__%2Fu) [n:127.0.0.1:44271__%2Fu ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@895c94c name:ZooKeeperConnection Watcher:127.0.0.1:35884/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 813574 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:44271__%2Fu ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 813578 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:44271__%2Fu ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 813578 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:44271__%2Fu ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties [junit4] 2> 813579 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:44271__%2Fu ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 813581 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:44271__%2Fu ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 813581 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:44271__%2Fu ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/96232419900129289-127.0.0.1:44271__%2Fu-n_0000000001 [junit4] 2> 813582 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:44271__%2Fu ] o.a.s.c.LeaderElector Watching path /overseer_elect/election/96232419900129284-127.0.0.1:37371__%2Fu-n_0000000000 to know if I could be the leader [junit4] 2> 813582 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:44271__%2Fu ] o.a.s.c.ZkController Publish node=127.0.0.1:44271__%2Fu as DOWN [junit4] 2> 813583 INFO (OverseerStateUpdate-96232419900129284-127.0.0.1:37371__%2Fu-n_0000000000) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"downnode", [junit4] 2> "node_name":"127.0.0.1:44271__%2Fu"} current state version: 3 [junit4] 2> 813583 INFO (OverseerStateUpdate-96232419900129284-127.0.0.1:37371__%2Fu-n_0000000000) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 127.0.0.1:44271__%2Fu [junit4] 2> 813584 INFO (zkCallback-879-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [1]) [junit4] 2> 813584 INFO (zkCallback-875-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu ] 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> 813585 INFO (zkCallback-885-thread-1-processing-n:127.0.0.1:44271__%2Fu) [n:127.0.0.1:44271__%2Fu ] 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> 813585 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:44271__%2Fu ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:44271__%2Fu [junit4] 2> 813585 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:44271__%2Fu ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:44271__%2Fu [junit4] 2> 813591 INFO (zkCallback-875-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [1]) [junit4] 2> 813591 INFO (zkCallback-879-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [1]) [junit4] 2> 813591 INFO (zkCallback-885-thread-1-processing-n:127.0.0.1:44271__%2Fu) [n:127.0.0.1:44271__%2Fu ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [1]) [junit4] 2> 813592 INFO (zkCallback-879-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 813592 INFO (zkCallback-875-thread-1-processing-n:127.0.0.1:37371__%2Fu) [n:127.0.0.1:37371__%2Fu ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 813597 INFO (zkCallback-885-thread-1-processing-n:127.0.0.1:44271__%2Fu) [n:127.0.0.1:44271__%2Fu ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 813604 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:44271__%2Fu ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 813604 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[EB0F404E15FE48A1]) [n:127.0.0.1:44271__%2Fu ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 813605 INFO (TEST-FullSol [...truncated too long message...] htlyTests-6.x/solr/core/test-lib/apacheds-interceptors-journal-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-normalization-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-operational-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-referral-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-schema-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-subtree-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-trigger-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-jdbm-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-jdbm1-2.0.0-M2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-kerberos-codec-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-ldif-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-mavibot-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-protocol-kerberos-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-protocol-ldap-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-protocol-shared-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-xdbm-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/api-all-1.0.0-M20.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/bcprov-jdk15-1.45.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/cglib-nodep-2.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/commons-collections-3.2.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/commons-math3-3.4.1.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/easymock-3.0.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/ehcache-core-2.4.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/hadoop-common-2.7.2-tests.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/hadoop-hdfs-2.7.2-tests.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/hadoop-minikdc-2.7.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/htrace-core-3.2.0-incubating.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jackson-annotations-2.5.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jackson-core-asl-1.9.13.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jackson-databind-2.5.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jackson-mapper-asl-1.9.13.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jersey-core-1.9.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jersey-server-1.9.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jetty-6.1.26.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jetty-util-6.1.26.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/mina-core-2.0.0-M5.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/mockito-core-1.9.5.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/netty-all-4.0.36.Final.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/objenesis-1.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/presto-parser-0.122.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/slice-0.10.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/build/analysis/icu/lucene-analyzers-icu-6.2.0-SNAPSHOT.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/contrib/solr-analysis-extras/classes/java:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/build/queryparser/classes/test:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/contrib/analysis-extras/lib/icu4j-56.1.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-launcher.jar:/x1/jenkins/.ant/lib/ivy-2.3.0.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-antlr.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-regexp.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-resolver.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-commons-net.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jmf.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-oro.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-xalan2.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-commons-logging.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jsch.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-junit4.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-javamail.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jai.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jdepend.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-junit.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-bsf.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-swing.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-netrexx.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-bcel.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-testutil.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-log4j.jar:/x1/jenkins/jenkins-slave/tools/hudson.model.JDK/latest1.8/lib/tools.jar:/x1/jenkins/.ivy2/cache/com.carrotsearch.randomizedtesting/junit4-ant/jars/junit4-ant-2.3.4.jar com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe -eventsfile /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/temp/junit4-J1-20160713_055619_667.events @/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/temp/junit4-J1-20160713_055619_667.suites -stdin [junit4] ERROR: JVM J1 ended with an exception: Quit event not received from the forked process? This may indicate JVM crash or runner bugs. [junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4.executeSlave(JUnit4.java:1501) [junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4.access$000(JUnit4.java:121) [junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:955) [junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:952) [junit4] at java.util.concurrent.FutureTask.run(FutureTask.java:266) [junit4] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [junit4] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] at java.lang.Thread.run(Thread.java:745) BUILD FAILED /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:748: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:685: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:59: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build.xml:233: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/common-build.xml:530: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:1443: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:984: At least one slave process threw an exception, first: Quit event not received from the forked process? This may indicate JVM crash or runner bugs. Total time: 288 minutes 25 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
