Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-5.5/16/
5 tests failed. FAILED: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test Error Message: Timeout occured while waiting response from server at: http://127.0.0.1:38483/nvwv Stack Trace: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:38483/nvwv at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:586) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.makeRequest(CollectionsAPIDistributedZkTest.java:400) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testErrorHandling(CollectionsAPIDistributedZkTest.java:516) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test(CollectionsAPIDistributedZkTest.java:179) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:606) 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:996) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:971) 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.read(SocketInputStream.java:152) at java.net.SocketInputStream.read(SocketInputStream.java:122) at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160) at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84) at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57) at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261) at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283) at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251) at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197) at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272) at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124) at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685) at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487) at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:482) ... 47 more FAILED: junit.framework.TestSuite.org.apache.solr.cloud.CollectionsAPIDistributedZkTest Error Message: 2 threads leaked from SUITE scope at org.apache.solr.cloud.CollectionsAPIDistributedZkTest: 1) Thread[id=104550, name=searcherExecutor-10263-thread-1, state=WAITING, group=TGRP-CollectionsAPIDistributedZkTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) at java.lang.Thread.run(Thread.java:745) 2) Thread[id=104547, name=searcherExecutor-10258-thread-1, state=WAITING, group=TGRP-CollectionsAPIDistributedZkTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) at java.lang.Thread.run(Thread.java:745) Stack Trace: com.carrotsearch.randomizedtesting.ThreadLeakError: 2 threads leaked from SUITE scope at org.apache.solr.cloud.CollectionsAPIDistributedZkTest: 1) Thread[id=104550, name=searcherExecutor-10263-thread-1, state=WAITING, group=TGRP-CollectionsAPIDistributedZkTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) at java.lang.Thread.run(Thread.java:745) 2) Thread[id=104547, name=searcherExecutor-10258-thread-1, state=WAITING, group=TGRP-CollectionsAPIDistributedZkTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) at java.lang.Thread.run(Thread.java:745) at __randomizedtesting.SeedInfo.seed([FF53D941DD25D8C8]:0) FAILED: junit.framework.TestSuite.org.apache.solr.cloud.CollectionsAPIDistributedZkTest Error Message: There are still zombie threads that couldn't be terminated: 1) Thread[id=104550, name=searcherExecutor-10263-thread-1, state=WAITING, group=TGRP-CollectionsAPIDistributedZkTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) at java.lang.Thread.run(Thread.java:745) 2) Thread[id=104547, name=searcherExecutor-10258-thread-1, state=WAITING, group=TGRP-CollectionsAPIDistributedZkTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) at java.lang.Thread.run(Thread.java:745) Stack Trace: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated: 1) Thread[id=104550, name=searcherExecutor-10263-thread-1, state=WAITING, group=TGRP-CollectionsAPIDistributedZkTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) at java.lang.Thread.run(Thread.java:745) 2) Thread[id=104547, name=searcherExecutor-10258-thread-1, state=WAITING, group=TGRP-CollectionsAPIDistributedZkTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) at java.lang.Thread.run(Thread.java:745) at __randomizedtesting.SeedInfo.seed([FF53D941DD25D8C8]:0) FAILED: org.apache.solr.cloud.RollingRestartTest.test Error Message: Unable to restart (#3): CloudJettyRunner [url=http://127.0.0.1:33810/collection1] Stack Trace: java.lang.AssertionError: Unable to restart (#3): CloudJettyRunner [url=http://127.0.0.1:33810/collection1] at __randomizedtesting.SeedInfo.seed([FF53D941DD25D8C8:7707E69B73D9B530]: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:57) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:606) 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:996) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:971) 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.TestReplicationHandler.doTestStressReplication Error Message: timed out waiting for collection1 startAt time to exceed: Tue Jun 21 00:27:10 BRT 2016 Stack Trace: java.lang.AssertionError: timed out waiting for collection1 startAt time to exceed: Tue Jun 21 00:27:10 BRT 2016 at __randomizedtesting.SeedInfo.seed([FF53D941DD25D8C8:24F8D987D80DB17B]:0) at org.junit.Assert.fail(Assert.java:93) at org.apache.solr.handler.TestReplicationHandler.watchCoreStartAt(TestReplicationHandler.java:1501) at org.apache.solr.handler.TestReplicationHandler.doTestStressReplication(TestReplicationHandler.java:853) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:606) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at java.lang.Thread.run(Thread.java:745) Build Log: [...truncated 11306 lines...] [junit4] Suite: org.apache.solr.cloud.RollingRestartTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/init-core-data-001 [junit4] 2> 182045 INFO (SUITE-RollingRestartTest-seed#[FF53D941DD25D8C8]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) [junit4] 2> 182045 INFO (SUITE-RollingRestartTest-seed#[FF53D941DD25D8C8]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: / [junit4] 2> 182049 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 182059 INFO (Thread-319) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 182059 INFO (Thread-319) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 182159 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.ZkTestServer start zk server on port:46923 [junit4] 2> 182159 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 182171 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 182186 INFO (zkCallback-90-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3eb25b6c name:ZooKeeperConnection Watcher:127.0.0.1:46923 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 182186 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 182186 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 182186 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 182189 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 182190 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 182190 INFO (zkCallback-91-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@71da0d2e name:ZooKeeperConnection Watcher:127.0.0.1:46923/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 182190 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 182190 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 182190 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1 [junit4] 2> 182192 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards [junit4] 2> 182193 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection [junit4] 2> 182194 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards [junit4] 2> 182195 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml [junit4] 2> 182195 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml [junit4] 2> 182197 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml [junit4] 2> 182197 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml [junit4] 2> 182198 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 182199 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 182200 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt [junit4] 2> 182200 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt [junit4] 2> 182201 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt [junit4] 2> 182201 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt [junit4] 2> 182202 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml [junit4] 2> 182202 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml [junit4] 2> 182203 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml [junit4] 2> 182204 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 182205 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json [junit4] 2> 182205 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 182206 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 182206 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 182207 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt [junit4] 2> 182207 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 182208 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt [junit4] 2> 182208 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt [junit4] 2> 182305 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/control-001/cores/collection1 [junit4] 2> 182307 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.e.j.s.Server jetty-9.2.13.v20150730 [junit4] 2> 182309 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@760822c{/,null,AVAILABLE} [junit4] 2> 182309 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.e.j.s.ServerConnector Started ServerConnector@51021a7c{HTTP/1.1}{127.0.0.1:46656} [junit4] 2> 182310 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.e.j.s.Server Started @184623ms [junit4] 2> 182310 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/tempDir-001/control/data, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/control-001/cores, hostPort=46656} [junit4] 2> 182310 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@7b3cb2c6 [junit4] 2> 182310 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/control-001' [junit4] 2> 182310 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 182310 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 182310 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 182327 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 182339 INFO (zkCallback-92-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@243702cd name:ZooKeeperConnection Watcher:127.0.0.1:46923/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 182339 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 182339 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 182343 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 182343 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/control-001/solr.xml [junit4] 2> 182353 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/control-001/cores [junit4] 2> 182354 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.CoreContainer New CoreContainer 1806851248 [junit4] 2> 182354 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/control-001] [junit4] 2> 182354 WARN (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/control-001/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/control-001/lib [junit4] 2> 182354 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] 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> 182355 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 182355 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 182355 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 182355 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46923/solr [junit4] 2> 182355 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 182355 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 182356 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 182357 INFO (zkCallback-95-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@325d8b7f name:ZooKeeperConnection Watcher:127.0.0.1:46923 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 182357 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 182357 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 182358 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.ZkController Added new OnReconnect listener org.apache.solr.cloud.ZkController$6@35e04a34 [junit4] 2> 182361 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 182361 INFO (zkCallback-96-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@125c4e0f name:ZooKeeperConnection Watcher:127.0.0.1:46923/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 182361 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 182367 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue [junit4] 2> 182368 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work [junit4] 2> 182371 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running [junit4] 2> 182372 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed [junit4] 2> 182425 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure [junit4] 2> 182427 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 182428 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 182430 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 182432 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 182433 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:46656_ [junit4] 2> 182433 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:46656_ [junit4] 2> 182435 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect [junit4] 2> 182436 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election [junit4] 2> 182437 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 182438 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/96107083774754820-127.0.0.1:46656_-n_0000000000 [junit4] 2> 182438 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:46656_ [junit4] 2> 182438 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader [junit4] 2> 182439 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.Overseer Overseer (id=96107083774754820-127.0.0.1:46656_-n_0000000000) starting [junit4] 2> 182441 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work [junit4] 2> 182446 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 182447 INFO (OverseerStateUpdate-96107083774754820-127.0.0.1:46656_-n_0000000000) [n:127.0.0.1:46656_ ] o.a.s.c.Overseer Starting to work on the main queue [junit4] 2> 182448 INFO (OverseerStateUpdate-96107083774754820-127.0.0.1:46656_-n_0000000000) [n:127.0.0.1:46656_ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 182455 INFO (OverseerCollectionConfigSetProcessor-96107083774754820-127.0.0.1:46656_-n_0000000000) [n:127.0.0.1:46656_ ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations [junit4] 2> 182459 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 182478 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 182478 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 182479 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/control-001/cores [junit4] 2> 182479 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {collection=control_collection, name=collection1, configSetProperties=configsetprops.json, schema=schema.xml, config=solrconfig.xml, dataDir=data/, loadOnStartup=true, transient=false, coreNodeName=, shard=} [junit4] 2> 182479 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.CorePropertiesLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/control-001/cores/collection1 [junit4] 2> 182480 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions [junit4] 2> 182484 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection x:collection1] o.a.s.c.ZkController publishing state=down [junit4] 2> 182484 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 182485 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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> 182485 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection x:collection1] o.a.s.c.c.ZkStateReader addZkWatch [control_collection] [junit4] 2> 182486 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection x:collection1] o.a.s.c.c.ZkStateReader Deleting data for [control_collection] [junit4] 2> 182487 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection x:collection1] o.a.s.c.ZkController look for our core node name [junit4] 2> 182491 INFO (OverseerStateUpdate-96107083774754820-127.0.0.1:46656_-n_0000000000) [n:127.0.0.1:46656_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "state":"down", [junit4] 2> "roles":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "node_name":"127.0.0.1:46656_", [junit4] 2> "operation":"state", [junit4] 2> "numShards":"1", [junit4] 2> "core":"collection1", [junit4] 2> "shard":null, [junit4] 2> "base_url":"http://127.0.0.1:46656"} current state version: 0 [junit4] 2> 182492 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0 [junit4] 2> 182492 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:46656_ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 182492 INFO (OverseerStateUpdate-96107083774754820-127.0.0.1:46656_-n_0000000000) [n:127.0.0.1:46656_ ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={ [junit4] 2> "state":"down", [junit4] 2> "roles":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "node_name":"127.0.0.1:46656_", [junit4] 2> "operation":"state", [junit4] 2> "numShards":"1", [junit4] 2> "core":"collection1", [junit4] 2> "shard":null, [junit4] 2> "base_url":"http://127.0.0.1:46656"} [junit4] 2> 182492 INFO (OverseerStateUpdate-96107083774754820-127.0.0.1:46656_-n_0000000000) [n:127.0.0.1:46656_ ] o.a.s.c.o.ClusterStateMutator building a new cName: control_collection [junit4] 2> 182493 INFO (OverseerStateUpdate-96107083774754820-127.0.0.1:46656_-n_0000000000) [n:127.0.0.1:46656_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1 [junit4] 2> 182494 INFO (zkCallback-96-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ ] 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> 182495 INFO (zkCallback-96-thread-2-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ ] 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> 183509 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection x:collection1] o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1 [junit4] 2> 183509 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection x:collection1] o.a.s.c.ZkController Check for collection zkNode:control_collection [junit4] 2> 183510 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection x:collection1] o.a.s.c.ZkController Collection zkNode exists [junit4] 2> 183510 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection x:collection1] o.a.s.c.c.ZkStateReader Load collection config from: [/collections/control_collection] [junit4] 2> 183510 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection x:collection1] o.a.s.c.c.ZkStateReader path=[/collections/control_collection] [configName]=[conf1] specified config exists in ZooKeeper [junit4] 2> 183510 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection x:collection1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/control-001/cores/collection1' [junit4] 2> 183511 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection x:collection1] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 183511 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection x:collection1] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 183513 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection x:collection1] o.a.s.c.Config loaded config solrconfig.xml with version 0 [junit4] 2> 183527 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 183535 WARN (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead. [junit4] 2> 183537 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.5.2 [junit4] 2> 183588 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection x:collection1] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml [junit4] 2> 183602 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 183885 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 183898 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection x:collection1] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 183899 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection x:collection1] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 184109 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 184113 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 184119 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 184122 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 184125 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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-5.5/solr/build/solr-core/test/J0 [junit4] 2> 184125 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection control_collection [junit4] 2> 184125 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore solr.StandardDirectoryFactory [junit4] 2> 184129 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/control-001/cores/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/control-001/cores/collection1/data/] [junit4] 2> 184129 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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@ecab30c [junit4] 2> 184139 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/control-001/cores/collection1/data [junit4] 2> 184140 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/control-001/cores/collection1/data/index/ [junit4] 2> 184140 WARN (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/control-001/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 184141 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/control-001/cores/collection1/data/index [junit4] 2> 184141 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=5, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7181942841187283] [junit4] 2> 184147 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/control-001/cores/collection1/data/index,segFN=segments_1,generation=1} [junit4] 2> 184147 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 184163 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "nodistrib" [junit4] 2> 184167 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:46656_ 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-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/control-001/cores/collection1/data/ [junit4] 2> 184171 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe" [junit4] 2> 184171 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 184171 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig" [junit4] 2> 184171 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 184171 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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> 184172 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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> 184172 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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> 184172 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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> 184172 WARN (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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> 184174 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 184175 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 184176 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 184177 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 184183 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/ping,/admin/file,/dump,/get,/schema,/admin/mbeans,/config,/admin/properties,/admin/system,/admin/segments,/replication,/update/json,standard,/update,/admin/luke,/admin/plugins,/update/csv,/update/json/docs,/admin/logging,/admin/threads [junit4] 2> 184184 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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> 184184 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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> 184184 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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> 184185 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 184185 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 184185 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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@7bf4664a [junit4] 2> 184186 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/control-001/cores/collection1/data/index,segFN=segments_1,generation=1} [junit4] 2> 184186 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 184186 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@1a1051de[collection1] main [junit4] 2> 184186 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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> 184187 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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> 184187 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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> 184187 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 184187 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {} [junit4] 2> 184187 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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> 184187 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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> 184187 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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> 184187 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 184188 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 184188 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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> 184188 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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> 184188 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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> 184188 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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 1537713342626398208 [junit4] 2> 184190 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ 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 1537713342626398208 [junit4] 2> 184190 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1 [junit4] 2> 184190 INFO (coreLoadExecutor-531-thread-1-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 184191 INFO (searcherExecutor-532-thread-1-processing-c:control_collection n:127.0.0.1:46656_ x:collection1 s:shard1 r:core_node1) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1a1051de[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 184192 INFO (coreZkRegister-525-thread-1-processing-c:control_collection n:127.0.0.1:46656_ x:collection1 s:shard1 r:core_node1) [n:127.0.0.1:46656_ 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:46656 collection:control_collection shard:shard1 [junit4] 2> 184192 INFO (coreZkRegister-525-thread-1-processing-c:control_collection n:127.0.0.1:46656_ x:collection1 s:shard1 r:core_node1) [n:127.0.0.1:46656_ 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> 184196 INFO (coreZkRegister-525-thread-1-processing-c:control_collection n:127.0.0.1:46656_ x:collection1 s:shard1 r:core_node1) [n:127.0.0.1:46656_ 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/96107083774754820-core_node1-n_0000000000 [junit4] 2> 184196 INFO (coreZkRegister-525-thread-1-processing-c:control_collection n:127.0.0.1:46656_ x:collection1 s:shard1 r:core_node1) [n:127.0.0.1:46656_ 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> 184198 INFO (OverseerStateUpdate-96107083774754820-127.0.0.1:46656_-n_0000000000) [n:127.0.0.1:46656_ ] 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> 184201 INFO (coreZkRegister-525-thread-1-processing-c:control_collection n:127.0.0.1:46656_ x:collection1 s:shard1 r:core_node1) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 184201 INFO (coreZkRegister-525-thread-1-processing-c:control_collection n:127.0.0.1:46656_ x:collection1 s:shard1 r:core_node1) [n:127.0.0.1:46656_ 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> 184201 INFO (coreZkRegister-525-thread-1-processing-c:control_collection n:127.0.0.1:46656_ x:collection1 s:shard1 r:core_node1) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:46656/collection1/ [junit4] 2> 184201 INFO (coreZkRegister-525-thread-1-processing-c:control_collection n:127.0.0.1:46656_ x:collection1 s:shard1 r:core_node1) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 184201 INFO (coreZkRegister-525-thread-1-processing-c:control_collection n:127.0.0.1:46656_ x:collection1 s:shard1 r:core_node1) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:46656/collection1/ has no replicas [junit4] 2> 184201 INFO (coreZkRegister-525-thread-1-processing-c:control_collection n:127.0.0.1:46656_ x:collection1 s:shard1 r:core_node1) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1 [junit4] 2> 184203 INFO (zkCallback-96-thread-3-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ ] 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> 184203 INFO (zkCallback-96-thread-4-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ ] 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> 184204 INFO (coreZkRegister-525-thread-1-processing-c:control_collection n:127.0.0.1:46656_ x:collection1 s:shard1 r:core_node1) [n:127.0.0.1:46656_ 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/96107083774754820-core_node1-n_0000000000 [junit4] 2> 184206 INFO (coreZkRegister-525-thread-1-processing-c:control_collection n:127.0.0.1:46656_ x:collection1 s:shard1 r:core_node1) [n:127.0.0.1:46656_ 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:46656/collection1/ shard1 [junit4] 2> 184206 INFO (OverseerStateUpdate-96107083774754820-127.0.0.1:46656_-n_0000000000) [n:127.0.0.1:46656_ ] 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:46656", [junit4] 2> "core":"collection1", [junit4] 2> "state":"active"} current state version: 2 [junit4] 2> 184311 INFO (zkCallback-96-thread-3-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ ] 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> 184311 INFO (zkCallback-96-thread-4-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ ] 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> 184361 INFO (coreZkRegister-525-thread-1-processing-c:control_collection n:127.0.0.1:46656_ x:collection1 s:shard1 r:core_node1) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController We are http://127.0.0.1:46656/collection1/ and leader is http://127.0.0.1:46656/collection1/ [junit4] 2> 184361 INFO (coreZkRegister-525-thread-1-processing-c:control_collection n:127.0.0.1:46656_ x:collection1 s:shard1 r:core_node1) [n:127.0.0.1:46656_ 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:46656 [junit4] 2> 184361 INFO (coreZkRegister-525-thread-1-processing-c:control_collection n:127.0.0.1:46656_ x:collection1 s:shard1 r:core_node1) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 184361 INFO (coreZkRegister-525-thread-1-processing-c:control_collection n:127.0.0.1:46656_ x:collection1 s:shard1 r:core_node1) [n:127.0.0.1:46656_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController publishing state=active [junit4] 2> 184361 INFO (coreZkRegister-525-thread-1-processing-c:control_collection n:127.0.0.1:46656_ x:collection1 s:shard1 r:core_node1) [n:127.0.0.1:46656_ 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> 184363 INFO (OverseerStateUpdate-96107083774754820-127.0.0.1:46656_-n_0000000000) [n:127.0.0.1:46656_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "state":"active", [junit4] 2> "roles":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "node_name":"127.0.0.1:46656_", [junit4] 2> "operation":"state", [junit4] 2> "numShards":"1", [junit4] 2> "core":"collection1", [junit4] 2> "shard":"shard1", [junit4] 2> "base_url":"http://127.0.0.1:46656"} current state version: 3 [junit4] 2> 184364 INFO (OverseerStateUpdate-96107083774754820-127.0.0.1:46656_-n_0000000000) [n:127.0.0.1:46656_ ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={ [junit4] 2> "state":"active", [junit4] 2> "roles":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "node_name":"127.0.0.1:46656_", [junit4] 2> "operation":"state", [junit4] 2> "numShards":"1", [junit4] 2> "core":"collection1", [junit4] 2> "shard":"shard1", [junit4] 2> "base_url":"http://127.0.0.1:46656"} [junit4] 2> 184466 INFO (zkCallback-96-thread-2-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ ] 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> 184466 INFO (zkCallback-96-thread-4-processing-n:127.0.0.1:46656_) [n:127.0.0.1:46656_ ] 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> 184542 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 184547 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 184548 INFO (zkCallback-98-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7ad386c9 name:ZooKeeperConnection Watcher:127.0.0.1:46923/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 184548 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 184548 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 184548 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 184550 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false [junit4] 2> 184613 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/shard-1-001/cores/collection1 [junit4] 2> 184613 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/shard-1-001 [junit4] 2> 184616 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.e.j.s.Server jetty-9.2.13.v20150730 [junit4] 2> 184627 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@184d645d{/,null,AVAILABLE} [junit4] 2> 184627 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.e.j.s.ServerConnector Started ServerConnector@f82222{HTTP/1.1}{127.0.0.1:45677} [junit4] 2> 184627 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.e.j.s.Server Started @186941ms [junit4] 2> 184628 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostPort=45677, hostContext=/, solrconfig=solrconfig.xml, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/shard-1-001/cores, solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/tempDir-001/jetty1} [junit4] 2> 184628 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@7b3cb2c6 [junit4] 2> 184628 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/shard-1-001' [junit4] 2> 184628 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 184628 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 184628 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 184630 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 184631 INFO (zkCallback-99-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4fe4351d name:ZooKeeperConnection Watcher:127.0.0.1:46923/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 184631 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 184631 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 184632 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 184632 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/shard-1-001/solr.xml [junit4] 2> 184641 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/shard-1-001/cores [junit4] 2> 184641 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.CoreContainer New CoreContainer 535152141 [junit4] 2> 184641 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/shard-1-001] [junit4] 2> 184642 WARN (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/shard-1-001/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_FF53D941DD25D8C8-001/shard-1-001/lib [junit4] 2> 184644 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] 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> 184645 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 184646 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 184646 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 184646 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46923/solr [junit4] 2> 184646 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 184646 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 184647 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 184648 INFO (zkCallback-102-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@68ee2460 name:ZooKeeperConnection Watcher:127.0.0.1:46923 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 184656 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 184656 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 184666 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:45677_ ] o.a.s.c.ZkController Added new OnReconnect listener org.apache.solr.cloud.ZkController$6@cab39ef [junit4] 2> 184679 INFO (TEST-RollingRestartTest.test-seed#[FF53D941DD25D8C8]) [n:127.0.0.1:45677_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 184691 INFO (zkCallback-103-thread-1-processing-n:127.0.0.1:45677_) [n:127.0. [...truncated too long message...] til.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> 2) Thread[id=104547, name=searcherExecutor-10258-thread-1, state=WAITING, group=TGRP-CollectionsAPIDistributedZkTest] [junit4] 2> at sun.misc.Unsafe.park(Native Method) [junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186) [junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043) [junit4] 2> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> NOTE: test params are: codec=Asserting(Lucene54), sim=DefaultSimilarity, locale=is-IS, timezone=America/Creston [junit4] 2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation 1.7.0_80 (64-bit)/cpus=4,threads=3,free=99903744,total=496500736 [junit4] 2> NOTE: All tests run in this JVM: [TestStressRecovery, SparseHLLTest, TestSearchPerf, TestManagedSynonymFilterFactory, TestDynamicFieldResource, ConfigSetsAPITest, SuggesterTSTTest, DistanceUnitsTest, BinaryUpdateRequestHandlerTest, DirectUpdateHandlerTest, FullHLLTest, TestManagedSchemaFieldResource, TestGroupingSearch, TestElisionMultitermQuery, AssignTest, SolrXmlInZkTest, TestTolerantSearch, SuggesterTest, CoreMergeIndexesAdminHandlerTest, TestIndexingPerformance, AnalyticsQueryTest, TestExtendedDismaxParser, ZkStateReaderTest, TestCopyFieldCollectionResource, TestPHPSerializedResponseWriter, StatsComponentTest, HdfsBasicDistributedZk2Test, TestRuleBasedAuthorizationPlugin, TestReload, TestFieldTypeCollectionResource, TestInfoStreamLogging, TestJmxIntegration, FullSolrCloudDistribCmdsTest, SpatialRPTFieldTypeTest, TestRestManager, AutoCommitTest, TestSort, RecoveryAfterSoftCommitTest, TestStressLiveNodes, FieldMutatingUpdateProcessorTest, SolrTestCaseJ4Test, TestScoreJoinQPScore, ScriptEngineTest, LeaderElectionTest, LukeRequestHandlerTest, OverseerTest, TestSchemaNameResource, TestMacros, TestExclusionRuleCollectionAccess, TestStressUserVersions, DistributedFacetPivotSmallTest, NoCacheHeaderTest, AnalysisErrorHandlingTest, TestExactStatsCache, AddSchemaFieldsUpdateProcessorFactoryTest, TestNoOpRegenerator, TestSweetSpotSimilarityFactory, DistributedQueryComponentOptimizationTest, PluginInfoTest, SimpleFacetsTest, StatelessScriptUpdateProcessorFactoryTest, TestExceedMaxTermLength, TestReloadDeadlock, TestWriterPerf, SuggesterWFSTTest, TestInitQParser, CollectionsAPIAsyncDistributedZkTest, TestCoreDiscovery, TestSolrIndexConfig, TestDistributedStatsComponentCardinality, HighlighterConfigTest, TestRecovery, DateRangeFieldTest, HdfsRecoverLeaseTest, TestSolrQueryParser, TestReloadAndDeleteDocs, CircularListTest, SegmentsInfoRequestHandlerTest, TestCryptoKeys, TestSolrDynamicMBean, PreAnalyzedUpdateProcessorTest, TestPostingsSolrHighlighter, WrapperMergePolicyFactoryTest, SolrCoreCheckLockOnStartupTest, TestZkChroot, TestStressReorder, SharedFSAutoReplicaFailoverUtilsTest, DistributedQueueTest, UpdateParamsTest, DateMathParserTest, DocValuesMultiTest, SaslZkACLProviderTest, TestCloudInspectUtil, FieldAnalysisRequestHandlerTest, BasicDistributedZkTest, ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test, UnloadDistributedZkTest, CollectionsAPIDistributedZkTest] [junit4] 2> NOTE: download the large Jenkins line-docs file by running 'ant get-jenkins-line-docs' in the lucene directory. [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=CollectionsAPIDistributedZkTest -Dtests.seed=FF53D941DD25D8C8 -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/x1/jenkins/lucene-data/enwiki.random.lines.txt -Dtests.locale=is-IS -Dtests.timezone=America/Creston -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 0.00s J2 | CollectionsAPIDistributedZkTest (suite) <<< [junit4] > Throwable #1: com.carrotsearch.randomizedtesting.ThreadLeakError: 2 threads leaked from SUITE scope at org.apache.solr.cloud.CollectionsAPIDistributedZkTest: [junit4] > 1) Thread[id=104550, name=searcherExecutor-10263-thread-1, state=WAITING, group=TGRP-CollectionsAPIDistributedZkTest] [junit4] > at sun.misc.Unsafe.park(Native Method) [junit4] > at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186) [junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043) [junit4] > at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) [junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068) [junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) [junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] > 2) Thread[id=104547, name=searcherExecutor-10258-thread-1, state=WAITING, group=TGRP-CollectionsAPIDistributedZkTest] [junit4] > at sun.misc.Unsafe.park(Native Method) [junit4] > at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186) [junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043) [junit4] > at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) [junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068) [junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) [junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] > at __randomizedtesting.SeedInfo.seed([FF53D941DD25D8C8]:0)Throwable #2: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated: [junit4] > 1) Thread[id=104550, name=searcherExecutor-10263-thread-1, state=WAITING, group=TGRP-CollectionsAPIDistributedZkTest] [junit4] > at sun.misc.Unsafe.park(Native Method) [junit4] > at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186) [junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043) [junit4] > at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) [junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068) [junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) [junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] > 2) Thread[id=104547, name=searcherExecutor-10258-thread-1, state=WAITING, group=TGRP-CollectionsAPIDistributedZkTest] [junit4] > at sun.misc.Unsafe.park(Native Method) [junit4] > at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186) [junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043) [junit4] > at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) [junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068) [junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) [junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] > at __randomizedtesting.SeedInfo.seed([FF53D941DD25D8C8]:0) [junit4] Completed [305/573 (3!)] on J2 in 772.26s, 1 test, 3 errors <<< FAILURES! [...truncated 815 lines...] BUILD FAILED /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/build.xml:757: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/build.xml:694: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/build.xml:59: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build.xml:233: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/common-build.xml:534: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/lucene/common-build.xml:1477: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/lucene/common-build.xml:1033: There were test failures: 573 suites (7 ignored), 2319 tests, 2 suite-level errors, 1 error, 2 failures, 893 ignored (12 assumptions) [seed: FF53D941DD25D8C8] Total time: 179 minutes 17 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