Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-6.x/51/
3 tests failed. FAILED: org.apache.solr.cloud.RollingRestartTest.test Error Message: Unable to restart (#6): CloudJettyRunner [url=http://127.0.0.1:52780/lfu/collection1] Stack Trace: java.lang.AssertionError: Unable to restart (#6): CloudJettyRunner [url=http://127.0.0.1:52780/lfu/collection1] at __randomizedtesting.SeedInfo.seed([6C1927A853BBAADC:E44D1872FD47C724]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.apache.solr.cloud.RollingRestartTest.restartWithRolesTest(RollingRestartTest.java:103) at org.apache.solr.cloud.RollingRestartTest.test(RollingRestartTest.java:52) 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) FAILED: org.apache.solr.handler.TestBlobHandler.doBlobHandlerTest Error Message: Could not find collection : .system Stack Trace: org.apache.solr.common.SolrException: Could not find collection : .system at __randomizedtesting.SeedInfo.seed([6C1927A853BBAADC:8CD805FAE857DC2E]:0) at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170) at org.apache.solr.handler.TestBlobHandler.doBlobHandlerTest(TestBlobHandler.java:73) 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) FAILED: org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.test Error Message: Timeout occured while waiting response from server at: http://127.0.0.1:44715/z Stack Trace: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:44715/z 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:416) 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 Build Log: [...truncated 12465 lines...] [junit4] Suite: org.apache.solr.cloud.RollingRestartTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/init-core-data-001 [junit4] 2> 3068400 INFO (SUITE-RollingRestartTest-seed#[6C1927A853BBAADC]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) [junit4] 2> 3068400 INFO (SUITE-RollingRestartTest-seed#[6C1927A853BBAADC]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /lfu/ [junit4] 2> 3068402 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 3068402 INFO (Thread-6969) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 3068402 INFO (Thread-6969) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 3068502 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.ZkTestServer start zk server on port:56566 [junit4] 2> 3068502 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 3068502 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 3068504 INFO (zkCallback-2327-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@355232dc name:ZooKeeperConnection Watcher:127.0.0.1:56566 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3068504 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 3068504 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 3068504 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 3068506 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 3068506 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 3068507 INFO (zkCallback-2328-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@66f5da7e name:ZooKeeperConnection Watcher:127.0.0.1:56566/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3068507 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 3068507 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 3068507 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1 [junit4] 2> 3068508 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards [junit4] 2> 3068508 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection [junit4] 2> 3068509 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards [junit4] 2> 3068510 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] 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> 3068510 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml [junit4] 2> 3068511 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml [junit4] 2> 3068511 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml [junit4] 2> 3068512 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] 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> 3068512 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 3068513 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] 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> 3068513 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt [junit4] 2> 3068514 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] 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> 3068514 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt [junit4] 2> 3068514 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] 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> 3068514 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml [junit4] 2> 3068515 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] 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> 3068515 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 3068516 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] 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> 3068516 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 3068517 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] 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> 3068517 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 3068518 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] 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> 3068518 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 3068518 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] 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> 3068518 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt [junit4] 2> 3068580 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/control-001/cores/collection1 [junit4] 2> 3068581 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314 [junit4] 2> 3068582 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@bd491b4{/lfu,null,AVAILABLE} [junit4] 2> 3068584 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.e.j.s.ServerConnector Started ServerConnector@4eb8a854{HTTP/1.1,[http/1.1]}{127.0.0.1:39860} [junit4] 2> 3068584 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.e.j.s.Server Started @3070892ms [junit4] 2> 3068584 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] 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/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/tempDir-001/control/data, hostContext=/lfu, hostPort=39860, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/control-001/cores} [junit4] 2> 3068584 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@73d16e93 [junit4] 2> 3068585 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/control-001' [junit4] 2> 3068585 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 3068585 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 3068585 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 3068585 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 3068586 INFO (zkCallback-2329-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@46c52704 name:ZooKeeperConnection Watcher:127.0.0.1:56566/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3068586 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 3068586 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 3068587 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 3068587 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/control-001/solr.xml [junit4] 2> 3068590 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] 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/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/control-001/cores [junit4] 2> 3068590 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.CoreContainer New CoreContainer 149423379 [junit4] 2> 3068590 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] 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/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/control-001] [junit4] 2> 3068590 WARN (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] 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/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/control-001/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/control-001/lib [junit4] 2> 3068590 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] 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> 3068591 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 3068591 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 3068591 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 3068591 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56566/solr [junit4] 2> 3068592 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 3068592 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 3068592 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 3068593 INFO (zkCallback-2332-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@23cab007 name:ZooKeeperConnection Watcher:127.0.0.1:56566 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3068593 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 3068593 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 3068594 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.ZkController Added new OnReconnect listener org.apache.solr.cloud.ZkController$$Lambda$74/628170364@6b81ed33 [junit4] 2> 3068594 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 3068594 INFO (zkCallback-2333-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4b693a6b name:ZooKeeperConnection Watcher:127.0.0.1:56566/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3068595 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 3068595 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue [junit4] 2> 3068596 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work [junit4] 2> 3068598 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running [junit4] 2> 3068599 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed [junit4] 2> 3068600 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure [junit4] 2> 3068601 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 3068601 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 3068602 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 3068603 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 3068604 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 3068604 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 3068605 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect [junit4] 2> 3068605 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election [junit4] 2> 3068606 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 3068606 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/95804997858951172-127.0.0.1:39860_lfu-n_0000000000 [junit4] 2> 3068607 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:39860_lfu [junit4] 2> 3068607 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader [junit4] 2> 3068607 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.Overseer Overseer (id=95804997858951172-127.0.0.1:39860_lfu-n_0000000000) starting [junit4] 2> 3068608 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work [junit4] 2> 3068611 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 3068611 INFO (OverseerCollectionConfigSetProcessor-95804997858951172-127.0.0.1:39860_lfu-n_0000000000) [n:127.0.0.1:39860_lfu ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations [junit4] 2> 3068611 INFO (OverseerStateUpdate-95804997858951172-127.0.0.1:39860_lfu-n_0000000000) [n:127.0.0.1:39860_lfu ] o.a.s.c.Overseer Starting to work on the main queue [junit4] 2> 3068611 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:39860_lfu [junit4] 2> 3068612 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:39860_lfu [junit4] 2> 3068613 INFO (OverseerStateUpdate-95804997858951172-127.0.0.1:39860_lfu-n_0000000000) [n:127.0.0.1:39860_lfu ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 3068613 INFO (zkCallback-2333-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu ] 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> 3068613 INFO (zkCallback-2333-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 3068625 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 3068625 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 3068625 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] 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/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/control-001/cores [junit4] 2> 3068626 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] 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> 3068626 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.CorePropertiesLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/control-001/cores/collection1 [junit4] 2> 3068626 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.c.CorePropertiesLocator Found 1 core definitions [junit4] 2> 3068627 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0 [junit4] 2> 3068627 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:39860_lfu ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 3068627 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection x:collection1] o.a.s.c.ZkController publishing state=down [junit4] 2> 3068627 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 3068627 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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> 3068627 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection x:collection1] o.a.s.c.c.ZkStateReader addZkWatch [control_collection] [junit4] 2> 3068627 INFO (OverseerStateUpdate-95804997858951172-127.0.0.1:39860_lfu-n_0000000000) [n:127.0.0.1:39860_lfu ] 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:39860/lfu";, [junit4] 2> "node_name":"127.0.0.1:39860_lfu", [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> 3068628 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection x:collection1] o.a.s.c.c.ZkStateReader Deleting data for [control_collection] [junit4] 2> 3068628 INFO (OverseerStateUpdate-95804997858951172-127.0.0.1:39860_lfu-n_0000000000) [n:127.0.0.1:39860_lfu ] 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:39860/lfu";, [junit4] 2> "node_name":"127.0.0.1:39860_lfu", [junit4] 2> "numShards":"1", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 3068628 INFO (OverseerStateUpdate-95804997858951172-127.0.0.1:39860_lfu-n_0000000000) [n:127.0.0.1:39860_lfu ] o.a.s.c.o.ClusterStateMutator building a new cName: control_collection [junit4] 2> 3068628 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection x:collection1] o.a.s.c.ZkController look for our core node name [junit4] 2> 3068628 INFO (OverseerStateUpdate-95804997858951172-127.0.0.1:39860_lfu-n_0000000000) [n:127.0.0.1:39860_lfu ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1 [junit4] 2> 3068629 INFO (zkCallback-2333-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu ] 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> 3069628 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection x:collection1] o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1 [junit4] 2> 3069629 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection x:collection1] o.a.s.c.ZkController Check for collection zkNode:control_collection [junit4] 2> 3069629 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection x:collection1] o.a.s.c.ZkController Collection zkNode exists [junit4] 2> 3069629 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection x:collection1] o.a.s.c.c.ZkStateReader Load collection config from: [/collections/control_collection] [junit4] 2> 3069629 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection x:collection1] o.a.s.c.c.ZkStateReader path=[/collections/control_collection] [configName]=[conf1] specified config exists in ZooKeeper [junit4] 2> 3069629 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/control-001/cores/collection1' [junit4] 2> 3069629 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection x:collection1] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 3069630 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection x:collection1] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 3069630 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection x:collection1] o.a.s.c.Config loaded config solrconfig.xml with version 0 [junit4] 2> 3069633 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 3069636 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.1.0 [junit4] 2> 3069642 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection x:collection1] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml [junit4] 2> 3069646 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 3069725 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 3069729 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection x:collection1] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 3069730 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection x:collection1] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 3069735 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 3069736 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 3069737 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 3069737 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 3069738 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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/J0 [junit4] 2> 3069738 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection control_collection [junit4] 2> 3069738 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore solr.StandardDirectoryFactory [junit4] 2> 3069738 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/control-001/cores/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/control-001/cores/collection1/data/] [junit4] 2> 3069738 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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@4aad92a [junit4] 2> 3069739 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/control-001/cores/collection1/data [junit4] 2> 3069739 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/control-001/cores/collection1/data/index/ [junit4] 2> 3069739 WARN (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/control-001/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 3069740 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/control-001/cores/collection1/data/index [junit4] 2> 3069740 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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@28158185 [junit4] 2> 3069746 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/control-001/cores/collection1/data/index,segFN=segments_1,generation=1} [junit4] 2> 3069746 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 3069746 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:39860_lfu 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/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/control-001/cores/collection1/data/ [junit4] 2> 3069748 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "nodistrib" [junit4] 2> 3069748 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe" [junit4] 2> 3069748 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 3069748 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig" [junit4] 2> 3069748 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 3069748 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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> 3069748 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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> 3069748 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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> 3069749 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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> 3069749 WARN (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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> 3069750 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 3069750 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 3069751 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 3069751 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 3069753 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,/dump,/update/csv,/sql,/update/json/docs,/admin/luke,/export,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/stream,/schema,/admin/plugins,/admin/logging,/update/json,/admin/ping,/admin/threads,/update,/admin/file [junit4] 2> 3069753 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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> 3069753 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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> 3069753 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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> 3069754 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 3069754 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 3069754 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=13, maxMergeAtOnceExplicit=35, maxMergedSegmentMB=1.8974609375, floorSegmentMB=0.494140625, forceMergeDeletesPctAllowed=26.138229044751252, segmentsPerTier=16.0, maxCFSSegmentSizeMB=0.2822265625, noCFSRatio=0.5015657907609108 [junit4] 2> 3069755 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/control-001/cores/collection1/data/index,segFN=segments_1,generation=1} [junit4] 2> 3069755 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 3069755 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@450e999a[collection1] main] [junit4] 2> 3069755 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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> 3069755 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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> 3069756 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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> 3069756 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 3069756 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {} [junit4] 2> 3069756 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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> 3069756 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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> 3069756 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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> 3069756 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 3069756 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 3069757 INFO (searcherExecutor-8520-thread-1-processing-n:127.0.0.1:39860_lfu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@450e999a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 3069757 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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> 3069757 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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> 3069757 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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> 3069757 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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 1532879967162990592 [junit4] 2> 3069759 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu 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 1532879967162990592 [junit4] 2> 3069759 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1 [junit4] 2> 3069759 INFO (coreLoadExecutor-8519-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 3069759 INFO (coreZkRegister-8513-thread-1-processing-n:127.0.0.1:39860_lfu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39860_lfu 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:39860/lfu collection:control_collection shard:shard1 [junit4] 2> 3069759 INFO (coreZkRegister-8513-thread-1-processing-n:127.0.0.1:39860_lfu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39860_lfu 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> 3069761 INFO (coreZkRegister-8513-thread-1-processing-n:127.0.0.1:39860_lfu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39860_lfu 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/95804997858951172-core_node1-n_0000000000 [junit4] 2> 3069761 INFO (coreZkRegister-8513-thread-1-processing-n:127.0.0.1:39860_lfu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39860_lfu 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> 3069762 INFO (coreZkRegister-8513-thread-1-processing-n:127.0.0.1:39860_lfu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 3069762 INFO (OverseerStateUpdate-95804997858951172-127.0.0.1:39860_lfu-n_0000000000) [n:127.0.0.1:39860_lfu ] 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> 3069762 INFO (coreZkRegister-8513-thread-1-processing-n:127.0.0.1:39860_lfu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39860_lfu 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> 3069762 INFO (coreZkRegister-8513-thread-1-processing-n:127.0.0.1:39860_lfu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:39860/lfu/collection1/ [junit4] 2> 3069762 INFO (coreZkRegister-8513-thread-1-processing-n:127.0.0.1:39860_lfu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 3069762 INFO (coreZkRegister-8513-thread-1-processing-n:127.0.0.1:39860_lfu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:39860/lfu/collection1/ has no replicas [junit4] 2> 3069763 INFO (coreZkRegister-8513-thread-1-processing-n:127.0.0.1:39860_lfu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1 [junit4] 2> 3069764 INFO (coreZkRegister-8513-thread-1-processing-n:127.0.0.1:39860_lfu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39860_lfu 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/95804997858951172-core_node1-n_0000000000 [junit4] 2> 3069765 INFO (coreZkRegister-8513-thread-1-processing-n:127.0.0.1:39860_lfu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39860_lfu 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:39860/lfu/collection1/ shard1 [junit4] 2> 3069765 INFO (OverseerStateUpdate-95804997858951172-127.0.0.1:39860_lfu-n_0000000000) [n:127.0.0.1:39860_lfu ] 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:39860/lfu";, [junit4] 2> "core":"collection1", [junit4] 2> "state":"active"} current state version: 1 [junit4] 2> 3069866 INFO (zkCallback-2333-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu ] 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> 3069915 INFO (coreZkRegister-8513-thread-1-processing-n:127.0.0.1:39860_lfu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController We are http://127.0.0.1:39860/lfu/collection1/ and leader is http://127.0.0.1:39860/lfu/collection1/ [junit4] 2> 3069916 INFO (coreZkRegister-8513-thread-1-processing-n:127.0.0.1:39860_lfu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39860_lfu 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:39860/lfu [junit4] 2> 3069916 INFO (coreZkRegister-8513-thread-1-processing-n:127.0.0.1:39860_lfu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 3069916 INFO (coreZkRegister-8513-thread-1-processing-n:127.0.0.1:39860_lfu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39860_lfu c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController publishing state=active [junit4] 2> 3069916 INFO (coreZkRegister-8513-thread-1-processing-n:127.0.0.1:39860_lfu x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:39860_lfu 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> 3069917 INFO (OverseerStateUpdate-95804997858951172-127.0.0.1:39860_lfu-n_0000000000) [n:127.0.0.1:39860_lfu ] 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:39860/lfu";, [junit4] 2> "node_name":"127.0.0.1:39860_lfu", [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> 3069920 INFO (OverseerStateUpdate-95804997858951172-127.0.0.1:39860_lfu-n_0000000000) [n:127.0.0.1:39860_lfu ] 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:39860/lfu";, [junit4] 2> "node_name":"127.0.0.1:39860_lfu", [junit4] 2> "numShards":"1", [junit4] 2> "state":"active", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 3070022 INFO (zkCallback-2333-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu ] 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> 3070128 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.s.i.CloudSolrClient Final constructed zkHost string: 127.0.0.1:56566/solr [junit4] 2> 3070128 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 3070128 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 3070129 INFO (zkCallback-2335-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@15bea059 name:ZooKeeperConnection Watcher:127.0.0.1:56566/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3070129 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 3070129 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 3070129 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 3070130 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 3070130 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false [junit4] 2> 3070186 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/shard-1-001/cores/collection1 [junit4] 2> 3070186 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] 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/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/shard-1-001 [junit4] 2> 3070187 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314 [junit4] 2> 3070187 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7dbb44d9{/lfu,null,AVAILABLE} [junit4] 2> 3070188 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.e.j.s.ServerConnector Started ServerConnector@336ed624{HTTP/1.1,[http/1.1]}{127.0.0.1:48017} [junit4] 2> 3070189 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.e.j.s.Server Started @3072496ms [junit4] 2> 3070189 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] 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/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/tempDir-001/jetty1, solrconfig=solrconfig.xml, hostContext=/lfu, hostPort=48017, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/shard-1-001/cores} [junit4] 2> 3070189 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@73d16e93 [junit4] 2> 3070189 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/shard-1-001' [junit4] 2> 3070189 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 3070189 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 3070189 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 3070190 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 3070191 INFO (zkCallback-2336-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@435da401 name:ZooKeeperConnection Watcher:127.0.0.1:56566/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3070191 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 3070192 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 3070192 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 3070192 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/shard-1-001/solr.xml [junit4] 2> 3070195 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] 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/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/shard-1-001/cores [junit4] 2> 3070196 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.CoreContainer New CoreContainer 873300638 [junit4] 2> 3070196 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] 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/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/shard-1-001] [junit4] 2> 3070196 WARN (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] 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/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/shard-1-001/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_6C1927A853BBAADC-001/shard-1-001/lib [junit4] 2> 3070196 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] 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> 3070197 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 3070197 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 3070197 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 3070197 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56566/solr [junit4] 2> 3070197 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 3070197 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 3070197 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 3070198 INFO (zkCallback-2339-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1fe29925 name:ZooKeeperConnection Watcher:127.0.0.1:56566 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3070198 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 3070198 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 3070199 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:48017_lfu ] o.a.s.c.ZkController Added new OnReconnect listener org.apache.solr.cloud.ZkController$$Lambda$74/628170364@10648ae9 [junit4] 2> 3070199 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:48017_lfu ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 3070200 INFO (zkCallback-2340-thread-1-processing-n:127.0.0.1:48017_lfu) [n:127.0.0.1:48017_lfu ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@65e3aeb3 name:ZooKeeperConnection Watcher:127.0.0.1:56566/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3070200 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:48017_lfu ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 3070203 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:48017_lfu ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 3070203 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:48017_lfu ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 3070204 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:48017_lfu ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 3070204 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:48017_lfu ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/95804997858951176-127.0.0.1:48017_lfu-n_0000000001 [junit4] 2> 3070205 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:48017_lfu ] o.a.s.c.LeaderElector Watching path /overseer_elect/election/95804997858951172-127.0.0.1:39860_lfu-n_0000000000 to know if I could be the leader [junit4] 2> 3070205 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:48017_lfu ] o.a.s.c.ZkController Publish node=127.0.0.1:48017_lfu as DOWN [junit4] 2> 3070206 INFO (OverseerStateUpdate-95804997858951172-127.0.0.1:39860_lfu-n_0000000000) [n:127.0.0.1:39860_lfu ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"downnode", [junit4] 2> "node_name":"127.0.0.1:48017_lfu"} current state version: 3 [junit4] 2> 3070206 INFO (OverseerStateUpdate-95804997858951172-127.0.0.1:39860_lfu-n_0000000000) [n:127.0.0.1:39860_lfu ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 127.0.0.1:48017_lfu [junit4] 2> 3070307 INFO (zkCallback-2335-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> 3070307 INFO (zkCallback-2333-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu ] 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> 3070307 INFO (zkCallback-2340-thread-1-processing-n:127.0.0.1:48017_lfu) [n:127.0.0.1:48017_lfu ] 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> 3071206 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:48017_lfu ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:48017_lfu [junit4] 2> 3071206 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:48017_lfu ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:48017_lfu [junit4] 2> 3071207 INFO (zkCallback-2335-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> 3071207 INFO (zkCallback-2333-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu ] 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> 3071207 INFO (zkCallback-2340-thread-1-processing-n:127.0.0.1:48017_lfu) [n:127.0.0.1:48017_lfu ] 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> 3071207 INFO (zkCallback-2333-thread-1-processing-n:127.0.0.1:39860_lfu) [n:127.0.0.1:39860_lfu ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 3071207 INFO (zkCallback-2340-thread-1-processing-n:127.0.0.1:48017_lfu) [n:127.0.0.1:48017_lfu ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 3071211 INFO (zkCallback-2335-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 3071224 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:48017_lfu ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 3071224 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0.1:48017_lfu ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 3071225 INFO (TEST-RollingRestartTest.test-seed#[6C1927A853BBAADC]) [n:127.0.0. [...truncated too long message...] pl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:834) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> Caused by: java.lang.NullPointerException [junit4] 2> at org.apache.hadoop.hdfs.server.blockmanagement.BlocksMap.size(BlocksMap.java:198) [junit4] 2> at org.apache.hadoop.hdfs.server.blockmanagement.BlockManager.getTotalBlocks(BlockManager.java:3291) [junit4] 2> at org.apache.hadoop.hdfs.server.namenode.FSNamesystem.getBlocksTotal(FSNamesystem.java:6223) [junit4] 2> ... 54 more [junit4] 2> 5552732 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[6C1927A853BBAADC]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_6C1927A853BBAADC-001 [junit4] 2> Apr 28, 2016 7:12:17 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 2 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Asserting(Lucene60), sim=RandomSimilarity(queryNorm=false,coord=crazy): {}, locale=is-IS, timezone=Australia/Melbourne [junit4] 2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation 1.8.0_74 (64-bit)/cpus=4,threads=2,free=147999152,total=510132224 [junit4] 2> NOTE: All tests run in this JVM: [TestRestoreCore, SpatialHeatmapFacetsTest, TestUseDocValuesAsStored2, BasicAuthIntegrationTest, OpenExchangeRatesOrgProviderTest, TestSolrCloudWithKerberosAlt, ResponseHeaderTest, BasicFunctionalityTest, TestBlendedInfixSuggestions, ConvertedLegacyTest, ZkSolrClientTest, HdfsNNFailoverTest, UpdateRequestProcessorFactoryTest, SegmentsInfoRequestHandlerTest, HdfsTlogReplayBufferedWhileIndexingTest, SortSpecParsingTest, UniqFieldsUpdateProcessorFactoryTest, TestCollapseQParserPlugin, TestDocumentBuilder, TestStressVersions, IndexBasedSpellCheckerTest, NotRequiredUniqueKeyTest, AddBlockUpdateTest, SpellCheckCollatorTest, LeaderInitiatedRecoveryOnShardRestartTest, CursorMarkTest, DistributedIntervalFacetingTest, SchemaVersionSpecificBehaviorTest, TestRandomCollapseQParserPlugin, TestRequestStatusCollectionAPI, TestTrackingShardHandlerFactory, TestSolrFieldCacheMBean, TestMiniSolrCloudCluster, TestSolrXml, TermsComponentTest, TestSystemIdResolver, SpellCheckComponentTest, TestExclusionRuleCollectionAccess, MBeansHandlerTest, TestQueryTypes, TestSurroundQueryParser, AsyncMigrateRouteKeyTest, TestFieldSortValues, ZkStateWriterTest, SpatialFilterTest, HighlighterTest, OverseerRolesTest, PreAnalyzedUpdateProcessorTest, TestShardHandlerFactory, SolrCmdDistributorTest, TestSolrDeletionPolicy2, TestQueryUtils, TestScoreJoinQPScore, BadCopyFieldTest, TestDynamicLoading, DocValuesMissingTest, ChaosMonkeySafeLeaderTest, ClusterStateUpdateTest, BJQParserTest, MultiTermTest, WordBreakSolrSpellCheckerTest, MoreLikeThisHandlerTest, TestCursorMarkWithoutUniqueKey, StressHdfsTest, TestFiltering, TestMinMaxOnMultiValuedField, SolrInfoMBeanTest, RecoveryAfterSoftCommitTest, FastVectorHighlighterTest, SimplePostToolTest, TestManagedSchemaAPI, ZkControllerTest, MinimalSchemaTest, TestSchemaResource, BigEndianAscendingWordDeserializerTest, DistribCursorPagingTest, HttpPartitionTest, TestRawResponseWriter, TestEmbeddedSolrServerConstructors, TestFastLRUCache, TestUniqueKeyFieldResource, TestSolrCoreProperties, FileUtilsTest, DocumentBuilderTest, SmileWriterTest, ShardRoutingTest, SolrIndexSplitterTest, DistributedQueryComponentOptimizationTest, SaslZkACLProviderTest, ConfigSetsAPITest, CollectionsAPIDistributedZkTest, TestSortingResponseWriter, ExplicitHLLTest, LoggingHandlerTest, TestQuerySenderListener, TestLFUCache, SpellPossibilityIteratorTest, DistributedFacetPivotLargeTest, HLLUtilTest, TestDistributedGrouping, TestHashPartitioner, TermVectorComponentDistributedTest, TestStressReorder, TestJoin, HardAutoCommitTest, DistributedTermsComponentTest, TestCoreContainer, SimpleFacetsTest, TestSolr4Spatial, PeerSyncTest, TestLazyCores, TestIndexSearcher, CurrencyFieldOpenExchangeTest, DistributedQueryElevationComponentTest, TestCoreDiscovery, SuggesterFSTTest, DocValuesTest, TermVectorComponentTest, RegexBoostProcessorTest, TestJmxIntegration, JSONWriterTest, TestPartialUpdateDeduplication, PingRequestHandlerTest, SOLR749Test, TestSolrIndexConfig, SolrIndexConfigTest, NumericFieldsTest, TestFuzzyAnalyzedSuggestions, ExternalFileFieldSortTest, TestCodecSupport, TestPerFieldSimilarity, TestLMJelinekMercerSimilarityFactory, TestBM25SimilarityFactory, TimeZoneUtilsTest, ResourceLoaderTest, PluginInfoTest, PreAnalyzedFieldTest, PrimUtilsTest, SpellingQueryConverterTest, DOMUtilTest, RAMDirectoryFactoryTest, ClusterStateTest, TestUtils, ZkNodePropsTest, SliceStateTest, DistributedMLTComponentTest, TestRTGBase, TestSimpleTrackingShardHandler, ConnectionReuseTest, CdcrReplicationHandlerTest, CloudExitableDirectoryReaderTest, CollectionReloadTest, CollectionsAPIAsyncDistributedZkTest, ConnectionManagerTest, CustomCollectionTest, DeleteShardTest, DistributedQueueTest, ForceLeaderTest, OutOfBoxZkACLAndCredentialsProvidersTest, OverriddenZkACLAndCredentialsProvidersTest, ReplicationFactorTest, RestartWhileUpdatingTest, SharedFSAutoReplicaFailoverTest, SharedFSAutoReplicaFailoverUtilsTest, SolrXmlInZkTest, TestCloudDeleteByQuery, TestCollectionAPI, TestDistribDocBasedVersion, TestDownShardTolerantSearch, TestMiniSolrCloudClusterBase, TestRebalanceLeaders, TestRequestForwarding, TestStressLiveNodes, VMParamsZkACLAndCredentialsProvidersTest, HdfsBasicDistributedZkTest, HdfsChaosMonkeyNothingIsSafeTest, HdfsCollectionsAPIDistributedZkTest] [junit4] Completed [591/591 (3!)] on J1 in 1715.09s, 1 test, 1 error <<< FAILURES! [...truncated 1 lines...] [junit4] JVM J1: stdout was not empty, see: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/temp/junit4-J1-20160428_173942_717.sysout [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] java.lang.OutOfMemoryError: Java heap space [junit4] Dumping heap to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/heapdumps/java_pid25977.hprof ... [junit4] Heap dump file created [715827357 bytes in 11.471 secs] [junit4] <<< JVM J1: EOF ---- [...truncated 12 lines...] BUILD FAILED /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:747: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:684: 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:529: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:1457: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:1014: There were test failures: 591 suites (10 ignored), 2393 tests, 2 errors, 1 failure, 31 ignored (16 assumptions) [seed: 6C1927A853BBAADC] Total time: 222 minutes 59 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
