Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-5.5/11/
4 tests failed. FAILED: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test Error Message: Timeout occured while waiting response from server at: http://127.0.0.1:56352/_/ou Stack Trace: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:56352/_/ou 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:477) 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: org.apache.solr.cloud.hdfs.HdfsBasicDistributedZkTest.test Error Message: No registered leader was found after waiting for 30000ms , collection: multiunload2 slice: shard1 Stack Trace: org.apache.solr.common.SolrException: No registered leader was found after waiting for 30000ms , collection: multiunload2 slice: shard1 at __randomizedtesting.SeedInfo.seed([B90C6B748F18A4EC:315854AE21E4C914]:0) at org.apache.solr.common.cloud.ZkStateReader.getLeaderRetry(ZkStateReader.java:628) at org.apache.solr.cloud.BasicDistributedZkTest.testStopAndStartCoresInOneInstance(BasicDistributedZkTest.java:589) at org.apache.solr.cloud.BasicDistributedZkTest.test(BasicDistributedZkTest.java:369) 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.search.stats.TestDistribIDF.testMultiCollectionQuery Error Message: expected:<2> but was:<1> Stack Trace: java.lang.AssertionError: expected:<2> but was:<1> at __randomizedtesting.SeedInfo.seed([B90C6B748F18A4EC:A87FAC45536EA190]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.failNotEquals(Assert.java:647) at org.junit.Assert.assertEquals(Assert.java:128) at org.junit.Assert.assertEquals(Assert.java:147) at org.apache.solr.search.stats.TestDistribIDF.testMultiCollectionQuery(TestDistribIDF.java:180) 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) FAILED: org.apache.solr.update.DirectUpdateHandlerTest.testExpungeDeletes Error Message: expected:<5> but was:<4> Stack Trace: java.lang.AssertionError: expected:<5> but was:<4> at __randomizedtesting.SeedInfo.seed([B90C6B748F18A4EC:95752FF1FAA16C49]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.failNotEquals(Assert.java:647) at org.junit.Assert.assertEquals(Assert.java:128) at org.junit.Assert.assertEquals(Assert.java:472) at org.junit.Assert.assertEquals(Assert.java:456) at org.apache.solr.update.DirectUpdateHandlerTest.testExpungeDeletes(DirectUpdateHandlerTest.java:299) 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 11225 lines...] [junit4] Suite: org.apache.solr.update.DirectUpdateHandlerTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001 [junit4] 2> 420811 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) [junit4] 2> 420811 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 420811 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1' [junit4] 2> 420811 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 420811 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr [junit4] 2> 420811 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 420812 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 420842 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 420860 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.5.1 [junit4] 2> 420894 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml [junit4] 2> 420898 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=test [junit4] 2> 421065 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 421065 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 421066 WARN (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (2) [junit4] 2> 421073 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 421075 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 421077 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 421077 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr [junit4] 2> 421077 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr' [junit4] 2> 421077 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 421077 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr [junit4] 2> 421078 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.c.CoreContainer New CoreContainer 1315792840 [junit4] 2> 421078 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr] [junit4] 2> 421078 WARN (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/lib [junit4] 2> 421078 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 421082 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true [junit4] 2> 421084 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 421084 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 421084 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 421084 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 421085 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {schema=schema12.xml, transient=false, collection=collection1, config=solrconfig.xml, configSetProperties=configsetprops.json, shard=shard1, loadOnStartup=true, dataDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001, name=collection1} [junit4] 2> 421086 INFO (coreLoadExecutor-1240-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1' [junit4] 2> 421095 INFO (coreLoadExecutor-1240-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 421095 INFO (coreLoadExecutor-1240-thread-1) [ ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr [junit4] 2> 421095 INFO (coreLoadExecutor-1240-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 421095 INFO (coreLoadExecutor-1240-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 421123 INFO (coreLoadExecutor-1240-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 421140 INFO (coreLoadExecutor-1240-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.5.1 [junit4] 2> 421177 INFO (coreLoadExecutor-1240-thread-1) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml [junit4] 2> 421183 INFO (coreLoadExecutor-1240-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 421358 INFO (coreLoadExecutor-1240-thread-1) [ ] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 421359 INFO (coreLoadExecutor-1240-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 421360 WARN (coreLoadExecutor-1240-thread-1) [ ] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (2) [junit4] 2> 421365 INFO (coreLoadExecutor-1240-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 421367 INFO (coreLoadExecutor-1240-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 421371 INFO (coreLoadExecutor-1240-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1' [junit4] 2> 421371 INFO (coreLoadExecutor-1240-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1 [junit4] 2> 421371 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockFSDirectoryFactory [junit4] 2> 421371 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001/] [junit4] 2> 421371 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@464ede69 [junit4] 2> 421372 INFO (coreLoadExecutor-1240-thread-1) [ 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/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001 [junit4] 2> 421372 INFO (coreLoadExecutor-1240-thread-1) [ 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/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001/index/ [junit4] 2> 421372 WARN (coreLoadExecutor-1240-thread-1) [ 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/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001/index' doesn't exist. Creating new index... [junit4] 2> 421372 INFO (coreLoadExecutor-1240-thread-1) [ 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/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001/index [junit4] 2> 421373 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=22, maxMergeAtOnceExplicit=41, maxMergedSegmentMB=30.2109375, floorSegmentMB=0.8125, forceMergeDeletesPctAllowed=11.48330353962817, segmentsPerTier=12.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8353595659925777 [junit4] 2> 421376 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=RawDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7894979),segFN=segments_1,generation=1} [junit4] 2> 421376 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 421377 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ 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/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001/ [junit4] 2> 421381 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe" [junit4] 2> 421382 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 421382 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 421382 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 421382 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig" [junit4] 2> 421382 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 421382 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 421382 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 421382 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 421382 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 421382 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 421382 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 421385 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 421387 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 421388 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 421390 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 421395 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy [junit4] 2> 421399 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /debug/dump,/admin/threads,/search-facet-invariants,/admin/logging,standard,/admin/luke,dismax,/replication,/terms,/admin/plugins,spellCheckCompRH,/admin/ping,/schema,lazy,/admin/segments,spellCheckWithWordbreak_Direct,mock,/update,spellCheckWithWordbreak,/config,spellCheckCompRH_Direct,defaults,/update/csv,/admin/mbeans,/admin/system,spellCheckCompRH1,/update/json,tvrh,/admin/file,/search-facet-def,mltrh,/get,/admin/properties,/mlt,/update/json/docs [junit4] 2> 421399 WARN (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.c.SolrCore solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 421400 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 421406 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 421406 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 421407 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=48, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=40.1181640625, floorSegmentMB=1.0, forceMergeDeletesPctAllowed=12.513928439968524, segmentsPerTier=8.0, maxCFSSegmentSizeMB=1.5947265625, noCFSRatio=1.0 [junit4] 2> 421408 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=RawDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7894979),segFN=segments_1,generation=1} [junit4] 2> 421408 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 421409 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@66861db[collection1] main [junit4] 2> 421409 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 421409 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage [junit4] 2> 421409 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 421410 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 421418 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 421445 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 421445 INFO (searcherExecutor-1241-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 421445 INFO (searcherExecutor-1241-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 421445 INFO (searcherExecutor-1241-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 421445 INFO (searcherExecutor-1241-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 421446 INFO (searcherExecutor-1241-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 421446 INFO (searcherExecutor-1241-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 421446 INFO (searcherExecutor-1241-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 421447 INFO (coreLoadExecutor-1240-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 421447 INFO (searcherExecutor-1241-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 421447 INFO (searcherExecutor-1241-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 421448 INFO (SUITE-DirectUpdateHandlerTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 421448 INFO (searcherExecutor-1241-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@66861db[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 421455 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testDeleteRollback [junit4] 2> 421455 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 421456 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0 [junit4] 2> 421459 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 421466 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=RawDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7894979),segFN=segments_1,generation=1} [junit4] 2> commit{dir=RawDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7894979),segFN=segments_2,generation=2} [junit4] 2> 421466 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 2 [junit4] 2> 421470 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@73b3847b[collection1] main [junit4] 2> 421471 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 421471 INFO (searcherExecutor-1241-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@73b3847b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 421472 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 12 [junit4] 2> 421473 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 421473 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1315792840 [junit4] 2> 421473 INFO (coreCloseExecutor-1245-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@4c83bb5f [junit4] 2> 421474 INFO (coreCloseExecutor-1245-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0} [junit4] 2> 421475 INFO (coreCloseExecutor-1245-thread-1) [ x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState [junit4] 2> 421475 INFO (coreCloseExecutor-1245-thread-1) [ x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter [junit4] 2> 421475 INFO (coreCloseExecutor-1245-thread-1) [ x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser [junit4] 2> 421479 INFO (coreCloseExecutor-1245-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request. [junit4] 2> 421497 INFO (coreCloseExecutor-1245-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockFSDirectoryFactory - 2 directories currently being tracked [junit4] 2> 421497 INFO (coreCloseExecutor-1245-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001/index [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001/index;done=false>>] [junit4] 2> 421497 INFO (coreCloseExecutor-1245-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001/index [junit4] 2> 421497 INFO (coreCloseExecutor-1245-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001 [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001;done=false>>] [junit4] 2> 421497 INFO (coreCloseExecutor-1245-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001 [junit4] 2> 421500 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 421500 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1' [junit4] 2> 421500 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 421500 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr [junit4] 2> 421500 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 421500 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 421519 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 421534 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.5.1 [junit4] 2> 421581 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml [junit4] 2> 421586 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.s.IndexSchema [null] Schema name=test [junit4] 2> 421729 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 421730 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 421731 WARN (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (2) [junit4] 2> 421742 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 421744 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 421746 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 421746 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr [junit4] 2> 421746 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr' [junit4] 2> 421746 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 421746 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr [junit4] 2> 421746 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.CoreContainer New CoreContainer 1423250701 [junit4] 2> 421746 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr] [junit4] 2> 421746 WARN (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/lib [junit4] 2> 421746 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 421748 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true [junit4] 2> 421749 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 421749 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 421749 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 421749 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 421749 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {schema=schema12.xml, loadOnStartup=true, name=collection1, collection=collection1, transient=false, config=solrconfig.xml, dataDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001, configSetProperties=configsetprops.json, shard=shard1} [junit4] 2> 421750 INFO (coreLoadExecutor-1252-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1' [junit4] 2> 421758 INFO (coreLoadExecutor-1252-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 421758 INFO (coreLoadExecutor-1252-thread-1) [ ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr [junit4] 2> 421758 INFO (coreLoadExecutor-1252-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 421758 INFO (coreLoadExecutor-1252-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 421793 INFO (coreLoadExecutor-1252-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 421808 INFO (coreLoadExecutor-1252-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.5.1 [junit4] 2> 421845 INFO (coreLoadExecutor-1252-thread-1) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml [junit4] 2> 421850 INFO (coreLoadExecutor-1252-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 422013 INFO (coreLoadExecutor-1252-thread-1) [ ] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 422014 INFO (coreLoadExecutor-1252-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 422015 WARN (coreLoadExecutor-1252-thread-1) [ ] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (2) [junit4] 2> 422020 INFO (coreLoadExecutor-1252-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 422022 INFO (coreLoadExecutor-1252-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 422026 INFO (coreLoadExecutor-1252-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1' [junit4] 2> 422026 INFO (coreLoadExecutor-1252-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1 [junit4] 2> 422026 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockFSDirectoryFactory [junit4] 2> 422026 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001/] [junit4] 2> 422026 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@464ede69 [junit4] 2> 422027 INFO (coreLoadExecutor-1252-thread-1) [ 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/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001 [junit4] 2> 422027 INFO (coreLoadExecutor-1252-thread-1) [ 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/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001/index/ [junit4] 2> 422028 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ 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/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001/ [junit4] 2> 422031 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe" [junit4] 2> 422031 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 422031 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 422031 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 422031 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig" [junit4] 2> 422031 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 422031 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 422031 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 422031 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 422031 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 422032 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 422032 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 422034 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 422035 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 422036 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 422037 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 422039 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy [junit4] 2> 422041 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /debug/dump,/admin/threads,/search-facet-invariants,/admin/logging,standard,/admin/luke,dismax,/replication,/terms,/admin/plugins,spellCheckCompRH,/admin/ping,/schema,lazy,/admin/segments,spellCheckWithWordbreak_Direct,mock,/update,spellCheckWithWordbreak,/config,spellCheckCompRH_Direct,defaults,/update/csv,/admin/mbeans,/admin/system,spellCheckCompRH1,/update/json,tvrh,/admin/file,/search-facet-def,mltrh,/get,/admin/properties,/mlt,/update/json/docs [junit4] 2> 422041 WARN (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.c.SolrCore solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 422042 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 422042 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 422042 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 422043 INFO (coreLoadExecutor-1252-thread-1) [ 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/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001/index [junit4] 2> 422043 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=22, maxMergeAtOnceExplicit=41, maxMergedSegmentMB=30.2109375, floorSegmentMB=0.8125, forceMergeDeletesPctAllowed=11.48330353962817, segmentsPerTier=12.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8353595659925777 [junit4] 2> 422044 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=RawDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7af36dad),segFN=segments_2,generation=2} [junit4] 2> 422044 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 2 [junit4] 2> 422044 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@74cda72b[collection1] main [junit4] 2> 422044 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 422044 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage [junit4] 2> 422044 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 422044 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 422045 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 422047 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 422047 INFO (searcherExecutor-1253-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 422047 INFO (searcherExecutor-1253-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 422047 INFO (searcherExecutor-1253-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 422047 INFO (searcherExecutor-1253-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 422048 INFO (searcherExecutor-1253-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 422048 INFO (searcherExecutor-1253-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 422048 INFO (searcherExecutor-1253-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 422048 INFO (searcherExecutor-1253-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 422049 INFO (searcherExecutor-1253-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 422050 INFO (searcherExecutor-1253-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@74cda72b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 422050 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 422051 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 422052 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[A]} 0 1 [junit4] 2> 422053 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[B]} 0 0 [junit4] 2> 422054 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 422079 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=RawDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7af36dad),segFN=segments_2,generation=2} [junit4] 2> commit{dir=RawDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7af36dad),segFN=segments_3,generation=3} [junit4] 2> 422080 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 3 [junit4] 2> 422082 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@51d25059[collection1] main [junit4] 2> 422082 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 422083 INFO (searcherExecutor-1253-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@51d25059[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.5.1):C2)))} [junit4] 2> 422085 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={indent=true&q=id:A+OR+id:B} hits=2 status=0 QTime=2 [junit4] 2> 422090 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{delete=[B]} 0 0 [junit4] 2> 422092 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={indent=true&q=id:A+OR+id:B} hits=2 status=0 QTime=9 [junit4] 2> 422095 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandler2 start rollback{} [junit4] 2> 422095 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1 [junit4] 2> 422095 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=14, maxMergeAtOnceExplicit=16, maxMergedSegmentMB=97.5517578125, floorSegmentMB=2.1015625, forceMergeDeletesPctAllowed=22.042737448322253, segmentsPerTier=18.0, maxCFSSegmentSizeMB=0.7294921875, noCFSRatio=0.0 [junit4] 2> 422097 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=RawDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7af36dad),segFN=segments_3,generation=3} [junit4] 2> 422097 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 3 [junit4] 2> 422097 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used. [junit4] 2> 422098 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandler2 end_rollback [junit4] 2> 422101 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={indent=true&q=id:A+OR+id:B} hits=2 status=0 QTime=17 [junit4] 2> 422103 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[ZZZ]} 0 0 [junit4] 2> 422104 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 422126 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=RawDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7af36dad),segFN=segments_3,generation=3} [junit4] 2> commit{dir=RawDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7af36dad),segFN=segments_4,generation=4} [junit4] 2> 422126 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 4 [junit4] 2> 422128 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@a4fa43f[collection1] main [junit4] 2> 422128 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 422131 INFO (searcherExecutor-1253-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@a4fa43f[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.5.1):C2) Uninverting(_1(5.5.1):C1)))} [junit4] 2> 422131 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 26 [junit4] 2> 422132 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={wt=xml&q=id:ZZZ} hits=1 status=0 QTime=0 [junit4] 2> 422133 INFO (TEST-DirectUpdateHandlerTest.testDeleteRollback-seed#[B90C6B748F18A4EC]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testDeleteRollback [junit4] 2> 422137 INFO (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[B90C6B748F18A4EC]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testPostSoftCommitEvents [junit4] 2> 422137 INFO (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 422137 INFO (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0 [junit4] 2> 422138 INFO (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 422140 INFO (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=RawDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7af36dad),segFN=segments_4,generation=4} [junit4] 2> commit{dir=RawDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7af36dad),segFN=segments_5,generation=5} [junit4] 2> 422141 INFO (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 5 [junit4] 2> 422141 INFO (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[B90C6B748F18A4EC]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@68eb3d4[collection1] main [junit4] 2> 422141 INFO (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 422142 INFO (searcherExecutor-1253-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@68eb3d4[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 422143 INFO (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 5 [junit4] 2> 422145 INFO (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[999]} 0 0 [junit4] 2> 422145 INFO (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false} [junit4] 2> 422149 INFO (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[B90C6B748F18A4EC]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@590d52a3[collection1] main [junit4] 2> 422149 INFO (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 422150 INFO (searcherExecutor-1253-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@590d52a3[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(5.5.1):C1)))} [junit4] 2> 422151 INFO (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 5 [junit4] 2> 422151 INFO (TEST-DirectUpdateHandlerTest.testPostSoftCommitEvents-seed#[B90C6B748F18A4EC]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testPostSoftCommitEvents [junit4] 2> 422156 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testPrepareCommit [junit4] 2> 422156 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 422156 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:*} 0 0 [junit4] 2> 422157 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 422160 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=RawDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7af36dad),segFN=segments_5,generation=5} [junit4] 2> commit{dir=RawDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7af36dad),segFN=segments_6,generation=6} [junit4] 2> 422160 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 6 [junit4] 2> 422160 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@6f4e5eb[collection1] main [junit4] 2> 422161 INFO (searcherExecutor-1253-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6f4e5eb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 422162 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 422163 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 5 [junit4] 2> 422165 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[999]} 0 0 [junit4] 2> 422166 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 422166 WARN (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandler2 Starting optimize... Reading and rewriting the entire index! Use with care. [junit4] 2> 422186 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=RawDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7af36dad),segFN=segments_6,generation=6} [junit4] 2> commit{dir=RawDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J2/temp/solr.update.DirectUpdateHandlerTest_B90C6B748F18A4EC-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7af36dad),segFN=segments_7,generation=7} [junit4] 2> 422186 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 7 [junit4] 2> 422187 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@794d6b71[collection1] main [junit4] 2> 422187 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 422189 INFO (searcherExecutor-1253-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@794d6b71[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(5.5.1):C1)))} [junit4] 2> 422189 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{optimize=} 0 23 [junit4] 2> 422190 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 422191 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit. [junit4] 2> 422192 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher [junit4] 2> 422192 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 422193 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 2 [junit4] 2> 422194 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandlerTest FILES before addDoc=[_3.tip, segments_7, _3.tim, _3.nvm, _3.doc, _3.fnm, _3.si, _3.fdx, _3.fdt, _3.nvd] [junit4] 2> 422199 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0 [junit4] 2> 422199 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandlerTest FILES before prepareCommit=[_3.tip, segments_7, _4.fdt, _3.tim, _3.nvm, _3.doc, _3.fnm, _4.fdx, _3.si, _3.fdx, _3.fdt, _3.nvd] [junit4] 2> 422200 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=true} [junit4] 2> 422222 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandler2 end_prepareCommit [junit4] 2> 422222 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={prepareCommit=true&wt=json&indent=true}{commit=} 0 22 [junit4] 2> 422222 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandlerTest FILES after prepareCommit=[_4.nvd, _3.tip, segments_7, _4.si, _4.tim, _4.fdt, _3.tim, _4.nvm, _3.nvm, _4.doc, _3.doc, pending_segments_8, _3.fnm, _4.fdx, _3.si, _3.fdx, _4.tip, _3.fdt, _3.nvd, _4.fnm] [junit4] 2> 422223 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={wt=xml&q=id:1} hits=0 status=0 QTime=0 [junit4] 2> 422223 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DirectUpdateHandler2 start rollback{} [junit4] 2> 422224 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1 [junit4] 2> 422227 INFO (TEST-DirectUpdateHandlerTest.testPrepareCommit-seed#[B90C6B748F18A4EC]) [ ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOn [...truncated too long message...] nt.java:806) [junit4] > at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219) [junit4] > at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1575) [junit4] > at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1596) [junit4] > at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:984)Throwable #6: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=21157, name=collection1, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest] [junit4] > Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:39347/_/ou: collection already exists: awholynewstresscollection_collection1_5 [junit4] > at __randomizedtesting.SeedInfo.seed([B90C6B748F18A4EC]:0) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:577) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230) [junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372) [junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1100) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806) [junit4] > at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219) [junit4] > at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1575) [junit4] > at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1596) [junit4] > at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:984)Throwable #7: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=21156, name=collection0, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest] [junit4] > Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:39347/_/ou, http://127.0.0.1:56352/_/ou, http://127.0.0.1:34904/_/ou, http://127.0.0.1:60551/_/ou, http://127.0.0.1:51380/_/ou] [junit4] > at __randomizedtesting.SeedInfo.seed([B90C6B748F18A4EC]:0) [junit4] > at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:994) [junit4] > Caused by: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:39347/_/ou, http://127.0.0.1:56352/_/ou, http://127.0.0.1:34904/_/ou, http://127.0.0.1:60551/_/ou, http://127.0.0.1:51380/_/ou] [junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:352) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1100) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806) [junit4] > at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219) [junit4] > at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1575) [junit4] > at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1596) [junit4] > at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:984) [junit4] > Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:56352/_/ou: KeeperErrorCode = Session expired for /overseer/collection-queue-work/qnr- [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:577) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230) [junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372) [junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325) [junit4] > ... 7 more [junit4] 2> 2932204 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[B90C6B748F18A4EC]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_B90C6B748F18A4EC-001 [junit4] 2> NOTE: test params are: codec=DummyCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=DUMMY, chunkSize=1, maxDocsPerChunk=774, blockSize=128), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=DUMMY, chunkSize=1, blockSize=128)), sim=DefaultSimilarity, locale=th-TH, timezone=Atlantic/Cape_Verde [junit4] 2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation 1.7.0_80 (64-bit)/cpus=4,threads=1,free=116885872,total=500695040 [junit4] 2> NOTE: All tests run in this JVM: [TestPartialUpdateDeduplication, DistanceFunctionTest, ZkControllerTest, ConjunctionSolrSpellCheckerTest, TestSortByMinMaxFunction, LeaderInitiatedRecoveryOnCommitTest, ConvertedLegacyTest, RequestLoggingTest, SpatialFilterTest, TestSmileRequest, TestSortingResponseWriter, DateRangeFieldTest, TestBM25SimilarityFactory, TestDistributedGrouping, CreateCollectionCleanupTest, TestNoOpRegenerator, SolrPluginUtilsTest, TestStressVersions, TestSolrConfigHandler, TestQueryUtils, HdfsNNFailoverTest, FileUtilsTest, TestUseDocValuesAsStored, SpatialRPTFieldTypeTest, SoftAutoCommitTest, AddSchemaFieldsUpdateProcessorFactoryTest, TestLMJelinekMercerSimilarityFactory, TestClusterStateMutator, TestDownShardTolerantSearch, SpellCheckCollatorTest, TestRuleBasedAuthorizationPlugin, DistributedIntervalFacetingTest, SolrIndexSplitterTest, SpellPossibilityIteratorTest, RuleEngineTest, OpenCloseCoreStressTest, HdfsChaosMonkeyNothingIsSafeTest, TestCollectionAPI, TestManagedSchemaFieldResource, FastVectorHighlighterTest, MultiTermTest, SolrCmdDistributorTest, TestReplicationHandlerBackup, MultiThreadedOCPTest, TestConfigSetsAPIZkFailure, TestScoreJoinQPScore, NotRequiredUniqueKeyTest, NumericFieldsTest, LoggingHandlerTest, ShardRoutingTest, SparseHLLTest, DeleteLastCustomShardedReplicaTest, DOMUtilTest, BasicFunctionalityTest, TestQuerySenderNoQuery, AnalyticsQueryTest, QueryResultKeyTest, UpdateRequestProcessorFactoryTest, TestMacros, TestSolrCloudWithKerberosAlt, VMParamsZkACLAndCredentialsProvidersTest, TestStressUserVersions, TestDefaultStatsCache, DistributedTermsComponentTest, TestRawResponseWriter, HighlighterTest, TestSolrDeletionPolicy2, TestJsonFacets, TestBinaryResponseWriter, FacetPivotSmallTest, SolrInfoMBeanTest, TestSolrConfigHandlerCloud, TestSimpleTrackingShardHandler, BlockJoinFacetRandomTest, MoreLikeThisHandlerTest, TestInitQParser, HdfsRestartWhileUpdatingTest, CollectionsAPIDistributedZkTest] [junit4] Completed [403/572 (4!)] on J1 in 1394.56s, 1 test, 1 error <<< FAILURES! [...truncated 590 lines...] [junit4] JVM J1: stdout was not empty, see: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/solr/build/solr-core/test/temp/junit4-J1-20160505_014053_823.sysout [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] java.lang.OutOfMemoryError: GC overhead limit exceeded [junit4] Dumping heap to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/heapdumps/java_pid13398.hprof ... [junit4] Heap dump file created [684141182 bytes in 8.893 secs] [junit4] <<< JVM J1: EOF ---- [...truncated 19 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: 572 suites (7 ignored), 2293 tests, 2 errors, 2 failures, 34 ignored (18 assumptions) [seed: B90C6B748F18A4EC] Total time: 191 minutes 30 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
