Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-master/1336/
5 tests failed. FAILED: org.apache.solr.cloud.hdfs.HdfsBasicDistributedZkTest.test Error Message: Error from server at http://127.0.0.1:42980: ADDREPLICA failed to create replica Stack Trace: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:42980: ADDREPLICA failed to create replica at __randomizedtesting.SeedInfo.seed([E10E9872A25D54AE:695AA7A80CA13956]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:624) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:250) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:239) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:470) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:400) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1102) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:843) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:774) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:178) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:195) at org.apache.solr.cloud.BasicDistributedZkTest.testANewCollectionInOneInstanceWithManualShardAssignement(BasicDistributedZkTest.java:808) at org.apache.solr.cloud.BasicDistributedZkTest.test(BasicDistributedZkTest.java:374) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:985) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960) 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:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) 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:368) at java.lang.Thread.run(Thread.java:748) FAILED: junit.framework.TestSuite.org.apache.solr.cloud.hdfs.HdfsBasicDistributedZkTest Error Message: 3 threads leaked from SUITE scope at org.apache.solr.cloud.hdfs.HdfsBasicDistributedZkTest: 1) Thread[id=5968, name=Connection evictor, state=TIMED_WAITING, group=TGRP-HdfsBasicDistributedZkTest] at java.lang.Thread.sleep(Native Method) at org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66) at java.lang.Thread.run(Thread.java:748) 2) Thread[id=5949, name=Connection evictor, state=TIMED_WAITING, group=TGRP-HdfsBasicDistributedZkTest] at java.lang.Thread.sleep(Native Method) at org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66) at java.lang.Thread.run(Thread.java:748) 3) Thread[id=5957, name=Connection evictor, state=TIMED_WAITING, group=TGRP-HdfsBasicDistributedZkTest] at java.lang.Thread.sleep(Native Method) at org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66) at java.lang.Thread.run(Thread.java:748) Stack Trace: com.carrotsearch.randomizedtesting.ThreadLeakError: 3 threads leaked from SUITE scope at org.apache.solr.cloud.hdfs.HdfsBasicDistributedZkTest: 1) Thread[id=5968, name=Connection evictor, state=TIMED_WAITING, group=TGRP-HdfsBasicDistributedZkTest] at java.lang.Thread.sleep(Native Method) at org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66) at java.lang.Thread.run(Thread.java:748) 2) Thread[id=5949, name=Connection evictor, state=TIMED_WAITING, group=TGRP-HdfsBasicDistributedZkTest] at java.lang.Thread.sleep(Native Method) at org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66) at java.lang.Thread.run(Thread.java:748) 3) Thread[id=5957, name=Connection evictor, state=TIMED_WAITING, group=TGRP-HdfsBasicDistributedZkTest] at java.lang.Thread.sleep(Native Method) at org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66) at java.lang.Thread.run(Thread.java:748) at __randomizedtesting.SeedInfo.seed([E10E9872A25D54AE]:0) FAILED: org.apache.solr.update.AutoCommitTest.testMaxDocs Error Message: Exception during query Stack Trace: java.lang.RuntimeException: Exception during query at __randomizedtesting.SeedInfo.seed([E10E9872A25D54AE:588F4EAD8EB75024]:0) at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:872) at org.apache.solr.update.AutoCommitTest.testMaxDocs(AutoCommitTest.java:225) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957) 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:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) 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:368) at java.lang.Thread.run(Thread.java:748) Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//result[@numFound=1] xml response was: <?xml version="1.0" encoding="UTF-8"?> <response> <lst name="responseHeader"><int name="status">0</int><int name="QTime">0</int></lst><result name="response" numFound="0" start="0"></result> </response> request was:q=id:14&qt=standard&start=0&rows=20&version=2.2 at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:865) ... 40 more FAILED: org.apache.solr.cloud.FullSolrCloudDistribCmdsTest.test Error Message: Java heap space Stack Trace: java.lang.OutOfMemoryError: Java heap space at __randomizedtesting.SeedInfo.seed([E10E9872A25D54AE:695AA7A80CA13956]:0) at java.util.Arrays.copyOf(Arrays.java:3332) at java.lang.AbstractStringBuilder.ensureCapacityInternal(AbstractStringBuilder.java:124) at java.lang.AbstractStringBuilder.append(AbstractStringBuilder.java:649) at java.lang.StringBuilder.append(StringBuilder.java:202) at org.apache.http.client.utils.URLEncodedUtils.urlEncode(URLEncodedUtils.java:522) at org.apache.http.client.utils.URLEncodedUtils.encodeFormFields(URLEncodedUtils.java:638) at org.apache.http.client.utils.URLEncodedUtils.format(URLEncodedUtils.java:390) at org.apache.http.client.utils.URLEncodedUtils.format(URLEncodedUtils.java:369) at org.apache.http.client.entity.UrlEncodedFormEntity.<init>(UrlEncodedFormEntity.java:77) at org.apache.solr.client.solrj.impl.HttpSolrClient.createMethod(HttpSolrClient.java:445) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:239) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:470) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:400) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1102) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:843) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:774) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:178) at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:974) at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:990) at org.apache.solr.cloud.CloudInspectUtil.compareResults(CloudInspectUtil.java:228) at org.apache.solr.cloud.CloudInspectUtil.compareResults(CloudInspectUtil.java:167) at org.apache.solr.cloud.FullSolrCloudDistribCmdsTest.testIndexingBatchPerRequestWithHttpSolrClient(FullSolrCloudDistribCmdsTest.java:668) at org.apache.solr.cloud.FullSolrCloudDistribCmdsTest.test(FullSolrCloudDistribCmdsTest.java:152) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957) FAILED: org.apache.solr.core.TestJmxIntegration.testJmxRegistration Error Message: org.apache.lucene.store.AlreadyClosedException: this Directory is closed Stack Trace: javax.management.RuntimeMBeanException: org.apache.lucene.store.AlreadyClosedException: this Directory is closed at __randomizedtesting.SeedInfo.seed([E10E9872A25D54AE:6FDFFC48CF1C0CCB]:0) at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.rethrow(DefaultMBeanServerInterceptor.java:839) at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.rethrowMaybeMBeanException(DefaultMBeanServerInterceptor.java:852) at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getAttribute(DefaultMBeanServerInterceptor.java:651) at com.sun.jmx.mbeanserver.JmxMBeanServer.getAttribute(JmxMBeanServer.java:678) at org.apache.solr.core.TestJmxIntegration.testJmxRegistration(TestJmxIntegration.java:121) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957) 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:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) 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:368) at java.lang.Thread.run(Thread.java:748) Caused by: org.apache.lucene.store.AlreadyClosedException: this Directory is closed at org.apache.lucene.store.BaseDirectory.ensureOpen(BaseDirectory.java:51) at org.apache.lucene.store.FSDirectory.listAll(FSDirectory.java:233) at org.apache.solr.core.DirectoryFactory.sizeOfDirectory(DirectoryFactory.java:271) at org.apache.solr.core.SolrCore.getIndexSize(SolrCore.java:407) at org.apache.solr.core.SolrCore.lambda$initializeMetrics$7(SolrCore.java:1137) at com.codahale.metrics.JmxReporter$JmxGauge.getValue(JmxReporter.java:188) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at sun.reflect.misc.Trampoline.invoke(MethodUtil.java:71) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at sun.reflect.misc.MethodUtil.invoke(MethodUtil.java:275) at com.sun.jmx.mbeanserver.StandardMBeanIntrospector.invokeM2(StandardMBeanIntrospector.java:112) at com.sun.jmx.mbeanserver.StandardMBeanIntrospector.invokeM2(StandardMBeanIntrospector.java:46) at com.sun.jmx.mbeanserver.MBeanIntrospector.invokeM(MBeanIntrospector.java:237) at com.sun.jmx.mbeanserver.PerInterface.getAttribute(PerInterface.java:83) at com.sun.jmx.mbeanserver.MBeanSupport.getAttribute(MBeanSupport.java:206) at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getAttribute(DefaultMBeanServerInterceptor.java:647) ... 41 more Build Log: [...truncated 11428 lines...] [junit4] Suite: org.apache.solr.update.AutoCommitTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_E10E9872A25D54AE-001/init-core-data-001 [junit4] 2> 167920 WARN (SUITE-AutoCommitTest-seed#[E10E9872A25D54AE]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2 [junit4] 2> 167921 INFO (SUITE-AutoCommitTest-seed#[E10E9872A25D54AE]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 167923 INFO (SUITE-AutoCommitTest-seed#[E10E9872A25D54AE]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN) [junit4] 2> 167928 INFO (SUITE-AutoCommitTest-seed#[E10E9872A25D54AE]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 167929 INFO (SUITE-AutoCommitTest-seed#[E10E9872A25D54AE]-worker) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 168092 INFO (SUITE-AutoCommitTest-seed#[E10E9872A25D54AE]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 168168 INFO (SUITE-AutoCommitTest-seed#[E10E9872A25D54AE]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=test [junit4] 2> 168619 INFO (SUITE-AutoCommitTest-seed#[E10E9872A25D54AE]-worker) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 168725 INFO (SUITE-AutoCommitTest-seed#[E10E9872A25D54AE]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@29c3cbc0 [junit4] 2> 168728 INFO (SUITE-AutoCommitTest-seed#[E10E9872A25D54AE]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@29c3cbc0 [junit4] 2> 168728 INFO (SUITE-AutoCommitTest-seed#[E10E9872A25D54AE]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@29c3cbc0 [junit4] 2> 168758 INFO (coreLoadExecutor-162-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 168975 INFO (coreLoadExecutor-162-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 169128 INFO (coreLoadExecutor-162-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 169772 INFO (coreLoadExecutor-162-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 169811 INFO (coreLoadExecutor-162-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 169812 INFO (coreLoadExecutor-162-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@29c3cbc0 [junit4] 2> 169820 INFO (coreLoadExecutor-162-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 169820 INFO (coreLoadExecutor-162-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_E10E9872A25D54AE-001/init-core-data-001/] [junit4] 2> 169825 INFO (coreLoadExecutor-162-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1392663930, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1] [junit4] 2> 170026 INFO (coreLoadExecutor-162-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 170026 INFO (coreLoadExecutor-162-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 170027 INFO (coreLoadExecutor-162-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 170027 INFO (coreLoadExecutor-162-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 170027 INFO (coreLoadExecutor-162-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=34, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 170028 INFO (coreLoadExecutor-162-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@9ff62e4[collection1] main] [junit4] 2> 170029 INFO (coreLoadExecutor-162-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 170040 INFO (coreLoadExecutor-162-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 170385 INFO (coreLoadExecutor-162-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 170386 INFO (searcherExecutor-163-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 170386 INFO (coreLoadExecutor-162-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1571152192838041600 [junit4] 2> 170395 INFO (SUITE-AutoCommitTest-seed#[E10E9872A25D54AE]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 170413 INFO (searcherExecutor-163-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 170413 INFO (searcherExecutor-163-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 170413 INFO (searcherExecutor-163-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 170413 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testMaxTime [junit4] 2> 170415 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 170415 INFO (searcherExecutor-163-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 170416 INFO (searcherExecutor-163-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 170418 INFO (searcherExecutor-163-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 170418 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@7490ea5d[collection1] realtime] [junit4] 2> 170419 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:* (-9223372036854775807)} 0 5 [junit4] 2> 170422 INFO (searcherExecutor-163-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 170422 ERROR (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ ] o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/core.properties [junit4] 2> 170423 INFO (searcherExecutor-163-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 170426 INFO (searcherExecutor-163-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@9ff62e4[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 170427 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 170670 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 171012 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 171223 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 171292 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ ] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1 [junit4] 2> 171357 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@29c3cbc0 [junit4] 2> 171357 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_E10E9872A25D54AE-001/init-core-data-001/] [junit4] 2> 171569 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 171569 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 171571 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@25f4fb1a[collection1] main] [junit4] 2> 171572 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 171574 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 171578 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 171578 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1571152194087944192 [junit4] 2> 171590 INFO (searcherExecutor-168-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 171590 INFO (searcherExecutor-168-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 171590 INFO (searcherExecutor-168-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 171590 INFO (searcherExecutor-168-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 171591 INFO (searcherExecutor-168-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 171591 INFO (searcherExecutor-168-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 171591 INFO (searcherExecutor-168-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 171592 INFO (searcherExecutor-168-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 171593 INFO (searcherExecutor-168-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 171595 INFO (searcherExecutor-168-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@25f4fb1a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 171607 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@1dfa5e50 [junit4] 2> 171607 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used. [junit4] 2> 171608 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@2f888b61[collection1] main] [junit4] 2> 171608 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@3402011b [junit4] 2> 171610 INFO (searcherExecutor-168-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2f888b61[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 171613 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=872546587 [junit4] 2> 171663 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 (1571152194156101632)]} 0 22 [junit4] 2> 171663 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 173146 INFO (commitScheduler-171-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false} [junit4] 2> 173176 INFO (commitScheduler-171-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@20d7a240[collection1] main] [junit4] 2> 173176 INFO (commitScheduler-171-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 173178 INFO (searcherExecutor-168-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@20d7a240[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c1)))} [junit4] 2> 173199 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 (1571152195786637312)]} 0 1558 [junit4] 2> 173199 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0 [junit4] 2> 173200 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 173201 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{delete=[529 (-1571152195789783040)]} 0 0 [junit4] 2> 173208 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0 [junit4] 2> 174699 INFO (commitScheduler-171-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false} [junit4] 2> 174712 INFO (commitScheduler-171-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@7f825270[collection1] main] [junit4] 2> 174715 INFO (commitScheduler-171-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 174719 INFO (searcherExecutor-168-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7f825270[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.0.0):c1)))} [junit4] 2> 174921 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[550 (1571152197588090880)]} 0 3280 [junit4] 2> 174921 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 174931 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1571152197603819520)]} 0 3290 [junit4] 2> 174931 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1571152197603819521)]} 0 3291 [junit4] 2> 174934 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1571152197604868096)]} 0 3293 [junit4] 2> 174936 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1571152197606965248)]} 0 3295 [junit4] 2> 174937 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1571152197609062400)]} 0 3296 [junit4] 2> 174937 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1571152197610110976)]} 0 3296 [junit4] 2> 174937 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1571152197610110977)]} 0 3297 [junit4] 2> 174947 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1571152197619548160)]} 0 3306 [junit4] 2> 174947 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1571152197620596736)]} 0 3306 [junit4] 2> 174947 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1571152197620596737)]} 0 3307 [junit4] 2> 174948 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:500&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 176422 INFO (commitScheduler-171-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false} [junit4] 2> 176433 INFO (commitScheduler-171-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3a957d86[collection1] main] [junit4] 2> 176435 INFO (searcherExecutor-168-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3a957d86[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.0.0):c1) Uninverting(_2(7.0.0):c11/9:delGen=1)))} [junit4] 2> 176436 INFO (commitScheduler-171-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 176496 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[531 (1571152199240646656)]} 0 4856 [junit4] 2> 176497 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:500&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0 [junit4] 2> 176497 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testMaxTime [junit4] 2> 176511 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.SolrTestCaseJ4 ###Starting testMaxDocs [junit4] 2> 176516 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 176520 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@2314542[collection1] realtime] [junit4] 2> 176520 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:* (-9223372036854775807)} 0 9 [junit4] 2> 176521 ERROR (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/core.properties [junit4] 2> 176521 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 176891 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 176938 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 177234 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 177261 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1 [junit4] 2> 177290 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@29c3cbc0 [junit4] 2> 177290 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_E10E9872A25D54AE-001/init-core-data-001/] [junit4] 2> 177570 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 177570 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 177571 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@69670b1a[collection1] main] [junit4] 2> 177572 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 177573 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 177582 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 177588 INFO (searcherExecutor-172-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 177589 INFO (searcherExecutor-172-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 177589 INFO (searcherExecutor-172-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 177589 INFO (searcherExecutor-172-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 177589 INFO (searcherExecutor-172-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 177592 INFO (searcherExecutor-172-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 177593 INFO (searcherExecutor-172-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 177593 INFO (searcherExecutor-172-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 177593 INFO (searcherExecutor-172-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 177687 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=29, maxMergeAtOnceExplicit=25, maxMergedSegmentMB=28.3984375, floorSegmentMB=0.3037109375, forceMergeDeletesPctAllowed=19.904743074171964, segmentsPerTier=19.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.47686791862082534 [junit4] 2> 177688 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used. [junit4] 2> 177800 INFO (searcherExecutor-172-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@69670b1a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 177800 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@556394ad[collection1] main] [junit4] 2> 177800 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@6711a381 [junit4] 2> 177801 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=1729209217 [junit4] 2> 177804 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 (1571152200615329792)]} 0 0 [junit4] 2> 177804 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[1 (1571152200616378368)]} 0 1 [junit4] 2> 177804 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[2 (1571152200616378369)]} 0 1 [junit4] 2> 177805 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3 (1571152200616378370)]} 0 1 [junit4] 2> 177805 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[4 (1571152200617426944)]} 0 2 [junit4] 2> 177806 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[5 (1571152200617426945)]} 0 2 [junit4] 2> 177806 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6 (1571152200618475520)]} 0 3 [junit4] 2> 177806 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[7 (1571152200618475521)]} 0 3 [junit4] 2> 177807 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[8 (1571152200618475522)]} 0 3 [junit4] 2> 177807 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9 (1571152200619524096)]} 0 4 [junit4] 2> 177807 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[10 (1571152200619524097)]} 0 4 [junit4] 2> 177808 INFO (searcherExecutor-172-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@556394ad[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 177810 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[11 (1571152200622669824)]} 0 7 [junit4] 2> 177811 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12 (1571152200622669825)]} 0 8 [junit4] 2> 177811 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[13 (1571152200623718400)]} 0 8 [junit4] 2> 177811 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:1&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 177825 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[14 (1571152200624766976)]} 0 22 [junit4] 2> 177825 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15 (1571152200638398464)]} 0 22 [junit4] 2> 177826 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:14&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 177826 ERROR (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.SolrTestCaseJ4 REQUEST FAILED: xpath=//result[@numFound=1] [junit4] 2> xml response was: <?xml version="1.0" encoding="UTF-8"?> [junit4] 2> <response> [junit4] 2> <lst name="responseHeader"><int name="status">0</int><int name="QTime">0</int></lst><result name="response" numFound="0" start="0"></result> [junit4] 2> </response> [junit4] 2> [junit4] 2> request was:q=id:14&qt=standard&start=0&rows=20&version=2.2 [junit4] 2> 177832 ERROR (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.SolrTestCaseJ4 REQUEST FAILED: q=id:14&qt=standard&start=0&rows=20&version=2.2:java.lang.RuntimeException: REQUEST FAILED: xpath=//result[@numFound=1] [junit4] 2> xml response was: <?xml version="1.0" encoding="UTF-8"?> [junit4] 2> <response> [junit4] 2> <lst name="responseHeader"><int name="status">0</int><int name="QTime">0</int></lst><result name="response" numFound="0" start="0"></result> [junit4] 2> </response> [junit4] 2> [junit4] 2> request was:q=id:14&qt=standard&start=0&rows=20&version=2.2 [junit4] 2> at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:865) [junit4] 2> at org.apache.solr.update.AutoCommitTest.testMaxDocs(AutoCommitTest.java:225) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) [junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> [junit4] 2> 177833 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testMaxDocs [junit4] 2> NOTE: download the large Jenkins line-docs file by running 'ant get-jenkins-line-docs' in the lucene directory. [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=AutoCommitTest -Dtests.method=testMaxDocs -Dtests.seed=E10E9872A25D54AE -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/test-data/enwiki.random.lines.txt -Dtests.locale=fr-CA -Dtests.timezone=Africa/Lome -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 1.34s J2 | AutoCommitTest.testMaxDocs <<< [junit4] > Throwable #1: java.lang.RuntimeException: Exception during query [junit4] > at __randomizedtesting.SeedInfo.seed([E10E9872A25D54AE:588F4EAD8EB75024]:0) [junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:872) [junit4] > at org.apache.solr.update.AutoCommitTest.testMaxDocs(AutoCommitTest.java:225) [junit4] > at java.lang.Thread.run(Thread.java:748) [junit4] > Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//result[@numFound=1] [junit4] > xml response was: <?xml version="1.0" encoding="UTF-8"?> [junit4] > <response> [junit4] > <lst name="responseHeader"><int name="status">0</int><int name="QTime">0</int></lst><result name="response" numFound="0" start="0"></result> [junit4] > </response> [junit4] > request was:q=id:14&qt=standard&start=0&rows=20&version=2.2 [junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:865) [junit4] > ... 40 more [junit4] 2> 177850 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.SolrTestCaseJ4 ###Starting testCommitWithin [junit4] 2> 177850 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 177850 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@659b79ba[collection1] realtime] [junit4] 2> 177851 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:* (-9223372036854775807)} 0 0 [junit4] 2> 177851 ERROR (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/core.properties [junit4] 2> 177851 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 177872 INFO (commitScheduler-175-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false} [junit4] 2> 177873 INFO (commitScheduler-175-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3709c026[collection1] main] [junit4] 2> 177873 INFO (commitScheduler-175-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 177874 INFO (searcherExecutor-172-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3709c026[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 177907 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 177955 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 178171 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 178203 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1 [junit4] 2> 178216 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@29c3cbc0 [junit4] 2> 178216 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_E10E9872A25D54AE-001/init-core-data-001/] [junit4] 2> 178710 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 178710 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 178711 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@2beae4a8[collection1] main] [junit4] 2> 178712 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 178712 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 178715 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 178718 INFO (searcherExecutor-176-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 178718 INFO (searcherExecutor-176-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 178718 INFO (searcherExecutor-176-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 178718 INFO (searcherExecutor-176-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 178718 INFO (searcherExecutor-176-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 178718 INFO (searcherExecutor-176-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 178719 INFO (searcherExecutor-176-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 178719 INFO (searcherExecutor-176-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 178719 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=42, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 178719 INFO (searcherExecutor-176-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 178720 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used. [junit4] 2> 178721 INFO (searcherExecutor-176-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2beae4a8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 178722 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@661c38a5[collection1] main] [junit4] 2> 178722 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@7b9527f [junit4] 2> 178723 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=129585791 [junit4] 2> 178737 INFO (searcherExecutor-176-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@661c38a5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 178756 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 (1571152201599942656)]} 0 17 [junit4] 2> 178757 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 182750 INFO (commitScheduler-179-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false} [junit4] 2> 182954 INFO (commitScheduler-179-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@222de3da[collection1] main] [junit4] 2> 182960 INFO (commitScheduler-179-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 182965 INFO (searcherExecutor-176-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@222de3da[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(7.0.0):c1)))} [junit4] 2> 183041 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 (1571152206104625152)]} 0 4301 [junit4] 2> 183041 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 183042 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[529 (-1571152206108819456)]} 0 4302 [junit4] 2> 183042 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0 [junit4] 2> 185042 INFO (commitScheduler-179-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false} [junit4] 2> 185118 INFO (commitScheduler-179-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@23b3dee[collection1] main] [junit4] 2> 185118 INFO (commitScheduler-179-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 185119 INFO (searcherExecutor-176-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@23b3dee[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_6(7.0.0):c1)))} [junit4] 2> 185295 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 185296 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0 [junit4] 2> 185310 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1571152208483844096)]} 0 6570 [junit4] 2> 185310 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1571152208486989824)]} 0 6570 [junit4] 2> 185310 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1571152208486989825)]} 0 6571 [junit4] 2> 185314 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1571152208491184128)]} 0 6575 [junit4] 2> 185315 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1571152208491184129)]} 0 6575 [junit4] 2> 185315 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1571152208492232704)]} 0 6575 [junit4] 2> 185315 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1571152208492232705)]} 0 6575 [junit4] 2> 185315 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1571152208492232706)]} 0 6576 [junit4] 2> 185315 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1571152208492232707)]} 0 6576 [junit4] 2> 185316 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1571152208493281280)]} 0 6576 [junit4] 2> 185316 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:500&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 185318 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1571152208494329856)]} 0 6578 [junit4] 2> 185318 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1571152208495378432)]} 0 6578 [junit4] 2> 185318 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1571152208495378433)]} 0 6578 [junit4] 2> 185659 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1571152208495378434)]} 0 6919 [junit4] 2> 185659 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1571152208852942848)]} 0 6919 [junit4] 2> 185659 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1571152208852942849)]} 0 6920 [junit4] 2> 185659 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1571152208852942850)]} 0 6920 [junit4] 2> 185660 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1571152208852942851)]} 0 6920 [junit4] 2> 185660 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1571152208853991424)]} 0 6920 [junit4] 2> 185660 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1571152208853991425)]} 0 6920 [junit4] 2> 185660 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0 [junit4] 2> 186318 INFO (commitScheduler-179-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false} [junit4] 2> 186331 INFO (commitScheduler-179-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@c87963a[collection1] main] [junit4] 2> 186331 INFO (commitScheduler-179-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 186332 INFO (searcherExecutor-176-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@c87963a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_7(7.0.0):c10/9:delGen=1)))} [junit4] 2> 186413 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:500&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0 [junit4] 2> 186414 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 186415 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E10E9872A25D54AE]) [ x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testCommitWithin [junit4] 2> 186415 INFO (SUITE-AutoCommitTest-seed#[E10E9872A25D54AE]-worker) [ x:collection1] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 186415 INFO (SUITE-AutoCommitTest-seed#[E10E9872A25D54AE]-worker) [ x:collection1] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1901875959 [junit4] 2> 186415 INFO (SUITE-AutoCommitTest-seed#[E10E9872A25D54AE]-worker) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 186420 INFO (SUITE-AutoCommitTest-seed#[E10E9872A25D54AE]-worker) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 186433 INFO (SUITE-AutoCommitTest-seed#[E10E9872A25D54AE]-worker) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 186563 INFO (SUITE-AutoCommitTest-seed#[E10E9872A25D54AE]-worker) [ x:collection1] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 186566 INFO (coreCloseExecutor-180-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@4fdb2459 [junit4] 2> 186566 INFO (coreCloseExecutor-180-thread-1-processing-x:collection1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close. [junit4] 2> 186566 INFO (coreCloseExecutor-180-thread-1-processing-x:collection1) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5f306de0 commitCommandVersion:0 [junit4] 2> 186618 INFO (coreCloseExecutor-180-thread-1-processing-x:collection1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=1339761753 [junit4] 2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_E10E9872A25D54AE-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {range_facet_l_dv=PostingsFormat(name=Direct), field_t=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), multiDefault=Lucene50(blocksize=128), subject=Lucene50(blocksize=128), intDefault=PostingsFormat(name=LuceneVarGapDocFreqInterval), id_i1=Lucene50(blocksize=128), id=PostingsFormat(name=Direct), range_facet_i_dv=PostingsFormat(name=LuceneVarGapDocFreqInterval), text=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), range_facet_l=PostingsFormat(name=LuceneVarGapDocFreqInterval), timestamp=PostingsFormat(name=LuceneVarGapDocFreqInterval)}, docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene70), _version_=DocValuesFormat(name=Lucene70), range_facet_i_dv=DocValuesFormat(name=Lucene70), intDvoDefault=DocValuesFormat(name=Direct), timestamp=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=171, maxMBSortInHeap=7.299123566621351, sim=RandomSimilarity(queryNorm=false): {}, locale=fr-CA, timezone=Africa/Lome [junit4] 2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation 1.8.0_131 (64-bit)/cpus=4,threads=1,free=226093672,total=449839104 [junit4] 2> NOTE: All tests run in this JVM: [AtomicUpdateProcessorFactoryTest, TestStressInPlaceUpdates, TestReplicationHandlerBackup, TestIndexSearcher, TestMacros, TestFieldCacheSortRandom, AutoCommitTest] [junit4] Completed [32/723 (1!)] on J2 in 18.97s, 3 tests, 1 error <<< FAILURES! [...truncated 219 lines...] [junit4] Suite: org.apache.solr.cloud.hdfs.HdfsBasicDistributedZkTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsBasicDistributedZkTest_E10E9872A25D54AE-001/init-core-data-001 [junit4] 2> 522714 WARN (SUITE-HdfsBasicDistributedZkTest-seed#[E10E9872A25D54AE]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=28 numCloses=28 [junit4] 2> 522714 INFO (SUITE-HdfsBasicDistributedZkTest-seed#[E10E9872A25D54AE]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=true [junit4] 2> 522716 INFO (SUITE-HdfsBasicDistributedZkTest-seed#[E10E9872A25D54AE]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-5776) [junit4] 2> 522716 INFO (SUITE-HdfsBasicDistributedZkTest-seed#[E10E9872A25D54AE]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: / [junit4] 1> Formatting using clusterid: testClusterID [junit4] 2> 522747 WARN (SUITE-HdfsBasicDistributedZkTest-seed#[E10E9872A25D54AE]-worker) [ ] o.a.h.m.i.MetricsConfig Cannot locate configuration: tried hadoop-metrics2-namenode.properties,hadoop-metrics2.properties [junit4] 2> 522752 WARN (SUITE-HdfsBasicDistributedZkTest-seed#[E10E9872A25D54AE]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j [junit4] 2> 522754 INFO (SUITE-HdfsBasicDistributedZkTest-seed#[E10E9872A25D54AE]-worker) [ ] o.m.log jetty-6.1.26 [junit4] 2> 522764 INFO (SUITE-HdfsBasicDistributedZkTest-seed#[E10E9872A25D54AE]-worker) [ ] o.m.log Extract jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.2-tests.jar!/webapps/hdfs to ./temp/Jetty_localhost_37713_hdfs____.nie9wh/webapp [junit4] 2> 523100 INFO (SUITE-HdfsBasicDistributedZkTest-seed#[E10E9872A25D54AE]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:37713 [junit4] 2> 523171 WARN (SUITE-HdfsBasicDistributedZkTest-seed#[E10E9872A25D54AE]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j [junit4] 2> 523172 INFO (SUITE-HdfsBasicDistributedZkTest-seed#[E10E9872A25D54AE]-worker) [ ] o.m.log jetty-6.1.26 [junit4] 2> 523182 INFO (SUITE-HdfsBasicDistributedZkTest-seed#[E10E9872A25D54AE]-worker) [ ] o.m.log Extract jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.2-tests.jar!/webapps/datanode to ./temp/Jetty_localhost_47754_datanode____.3om7za/webapp [junit4] 2> 523595 INFO (SUITE-HdfsBasicDistributedZkTest-seed#[E10E9872A25D54AE]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:47754 [junit4] 2> 523693 INFO (IPC Server handler 4 on 46629) [ ] BlockStateChange BLOCK* processReport: from storage DS-e44b3bce-c126-4d76-9c0e-63c5ed033e4e node DatanodeRegistration(127.0.0.1:60303, datanodeUuid=51537665-d2bc-4fa0-91a0-0c3ce9462ea4, infoPort=57721, infoSecurePort=0, ipcPort=43591, storageInfo=lv=-56;cid=testClusterID;nsid=1543253159;c=0), blocks: 0, hasStaleStorage: true, processing time: 1 msecs [junit4] 2 [...truncated too long message...] 1parent_f2_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), 6child3_s=PostingsFormat(name=Memory), 7grand0_s=FSTOrd50, text_t=PostingsFormat(name=LuceneVarGapFixedInterval), 24parent_f2_s=PostingsFormat(name=Memory), 44parent_f2_s=FSTOrd50, 34parent_f2_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), 13parent_f2_s=PostingsFormat(name=Memory), type_s=PostingsFormat(name=LuceneVarGapFixedInterval), 23parent_f2_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), 5child1_s=PostingsFormat(name=LuceneVarGapFixedInterval), 43parent_f2_s=PostingsFormat(name=LuceneVarGapFixedInterval), 10parent_f1_s=FSTOrd50, 33parent_f2_s=FSTOrd50, 11grand1_s=FSTOrd50, 22parent_f2_s=FSTOrd50, 10grand0_s=FSTOrd50, 4child0_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), 11grand5_s=FSTOrd50, 12parent_f2_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), 10grand8_s=FSTOrd50, 42parent_f2_s=PostingsFormat(name=Memory), 10grand4_s=FSTOrd50, 32parent_f2_s=PostingsFormat(name=LuceneVarGapFixedInterval), 31parent_f1_s=PostingsFormat(name=LuceneVarGapFixedInterval), 5grand1_s=PostingsFormat(name=LuceneVarGapFixedInterval), 6grand4_s=PostingsFormat(name=LuceneVarGapFixedInterval), 11parent_f1_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), 4grand2_s=PostingsFormat(name=LuceneVarGapFixedInterval), 21parent_f1_s=FSTOrd50, 7grand3_s=PostingsFormat(name=LuceneVarGapFixedInterval), 11grand9_s=FSTOrd50, 8grand2_s=PostingsFormat(name=LuceneVarGapFixedInterval), 9grand5_s=PostingsFormat(name=LuceneVarGapFixedInterval), 8grand6_s=PostingsFormat(name=LuceneVarGapFixedInterval), 9grand1_s=PostingsFormat(name=LuceneVarGapFixedInterval), 41parent_f1_s=PostingsFormat(name=Memory), 37parent_f1_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), 40parent_f2_s=FSTOrd50, 47parent_f1_s=FSTOrd50, 14parent_f1_s=FSTOrd50, 20parent_f2_s=PostingsFormat(name=Memory), 34parent_f1_s=PostingsFormat(name=Memory), 6child4_s=PostingsFormat(name=LuceneVarGapFixedInterval), 24parent_f1_s=PostingsFormat(name=LuceneVarGapFixedInterval), 44parent_f1_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), 30parent_f2_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), 5parent_f1_s=FSTOrd50, 6grand0_s=PostingsFormat(name=LuceneVarGapFixedInterval), 46parent_f2_s=PostingsFormat(name=Memory), 10parent_f2_s=PostingsFormat(name=LuceneVarGapFixedInterval), 5child0_s=FSTOrd50, 8parent_f1_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), 27parent_f2_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), 2parent_f2_s=FSTOrd50, 11grand0_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), 4child1_s=PostingsFormat(name=Memory), 2grand1_s=FSTOrd50, 11grand4_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), 17parent_f2_s=FSTOrd50, 3child2_s=PostingsFormat(name=Memory), 16parent_f2_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), 10grand5_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), 26parent_f2_s=FSTOrd50, 1child0_s=PostingsFormat(name=Memory), 36parent_f2_s=PostingsFormat(name=LuceneVarGapFixedInterval), 10grand1_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), 7grand6_s=PostingsFormat(name=Memory), 5grand0_s=PostingsFormat(name=Memory), 18parent_f1_s=PostingsFormat(name=Memory), 28parent_f1_s=PostingsFormat(name=LuceneVarGapFixedInterval), 6grand5_s=PostingsFormat(name=Memory), 7grand2_s=PostingsFormat(name=Memory), 4grand3_s=PostingsFormat(name=Memory), 9grand8_s=FSTOrd50, 15parent_f1_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), 11grand8_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), 8grand3_s=PostingsFormat(name=Memory), 6parent_f1_s=PostingsFormat(name=LuceneVarGapFixedInterval), 9grand4_s=FSTOrd50, 25parent_f1_s=FSTOrd50, 8grand7_s=PostingsFormat(name=Memory), 0parent_f1_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), 3grand2_s=PostingsFormat(name=Memory), 9grand0_s=FSTOrd50, 35parent_f1_s=PostingsFormat(name=LuceneVarGapFixedInterval), 4parent_f2_s=PostingsFormat(name=Memory), 19parent_f2_s=PostingsFormat(name=Memory), 37parent_f2_s=FSTOrd50, 47parent_f2_s=PostingsFormat(name=LuceneVarGapFixedInterval), 5child4_s=FSTOrd50, 6child5_s=FSTOrd50, 5grand4_s=PostingsFormat(name=Memory), 38parent_f1_s=PostingsFormat(name=Memory), 6grand1_s=PostingsFormat(name=Memory), 5parent_f2_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), 46parent_f1_s=PostingsFormat(name=LuceneVarGapFixedInterval), 6child0_s=PostingsFormat(name=LuceneVarGapFixedInterval), 16parent_f1_s=FSTOrd50, 8parent_f2_s=PostingsFormat(name=Memory), 39parent_f2_s=PostingsFormat(name=Memory), 29parent_f2_s=PostingsFormat(name=LuceneVarGapFixedInterval), 2parent_f1_s=PostingsFormat(name=LuceneVarGapFixedInterval), 4child2_s=PostingsFormat(name=LuceneVarGapFixedInterval), rnd_b=PostingsFormat(name=Memory), 11grand3_s=PostingsFormat(name=Memory), 27parent_f1_s=PostingsFormat(name=Memory), 45parent_f1_s=PostingsFormat(name=Memory), 17parent_f1_s=PostingsFormat(name=LuceneVarGapFixedInterval), 2grand0_s=PostingsFormat(name=LuceneVarGapFixedInterval), 11grand7_s=PostingsFormat(name=Memory), 3child1_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), 10grand6_s=PostingsFormat(name=Memory), 7parent_f2_s=PostingsFormat(name=LuceneVarGapFixedInterval), 26parent_f1_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), 10grand2_s=PostingsFormat(name=Memory), 2child0_s=PostingsFormat(name=LuceneVarGapFixedInterval), 3parent_f1_s=PostingsFormat(name=Memory), 36parent_f1_s=FSTOrd50}, docValues:{_version_=DocValuesFormat(name=Memory), id=DocValuesFormat(name=Lucene70), text_t=DocValuesFormat(name=Memory)}, maxPointsInLeafNode=1327, maxMBSortInHeap=7.260504485524939, sim=RandomSimilarity(queryNorm=false): {}, locale=ar-OM, timezone=Egypt [junit4] 2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation 1.8.0_131 (64-bit)/cpus=4,threads=1,free=40837008,total=521666560 [junit4] 2> NOTE: All tests run in this JVM: [AtomicUpdateProcessorFactoryTest, TestStressInPlaceUpdates, TestReplicationHandlerBackup, TestIndexSearcher, TestMacros, TestFieldCacheSortRandom, AutoCommitTest, TestGeoJSONResponseWriter, DistributedSuggestComponentTest, OverseerModifyCollectionTest, TestQueryTypes, TestZkChroot, TestComplexPhraseQParserPlugin, SuggesterFSTTest, SearchHandlerTest, RestartWhileUpdatingTest, TestFastOutputStream, BlockJoinFacetRandomTest, HdfsDirectoryTest, TestBinaryField, TestCloudSchemaless, CoreMergeIndexesAdminHandlerTest, TestReRankQParserPlugin, SuggestComponentContextFilterQueryTest, TestSolrCloudSnapshots, UpdateParamsTest, DirectoryFactoryTest, CdcrReplicationHandlerTest, TestClusterProperties, PropertiesRequestHandlerTest, TestImplicitCoreProperties, TestSerializedLuceneMatchVersion, SolrInfoBeanTest, QueryResultKeyTest, StatsReloadRaceTest, TestRebalanceLeaders, TestMultiValuedNumericRangeQuery, DateRangeFieldTest, ResponseLogComponentTest, TestQueryWrapperFilter, DateMathParserTest, TestSurroundQueryParser, TestSuggestSpellingConverter, TestConfigSetsAPIExclusivity, TestSolrQueryResponse, SaslZkACLProviderTest, TestLegacyFieldCache, TestMiniSolrCloudClusterSSL, TestCorePropertiesReload, RulesTest, SpellCheckCollatorWithCollapseTest, OverseerTaskQueueTest, TestPushWriter, QueryEqualityTest, BigEndianAscendingWordSerializerTest, TestRequestStatusCollectionAPI, TestJettySolrRunner, DistributedExpandComponentTest, StressHdfsTest, TestUseDocValuesAsStored, BasicAuthStandaloneTest, TestGroupingSearch, SolrMetricReporterTest, FullHLLTest, TestShortCircuitedRequests, TestCodecSupport, CollectionsAPISolrJTest, ConnectionManagerTest, TestPostingsSolrHighlighter, SimpleFacetsTest, DeleteReplicaTest, HdfsTlogReplayBufferedWhileIndexingTest, ShowFileRequestHandlerTest, BlockCacheTest, UtilsToolTest, HdfsChaosMonkeyNothingIsSafeTest, TestCloudNestedDocsSort, RecoveryZkTest, BasicDistributedZk2Test, StatsComponentTest, ExternalFileFieldSortTest, TestSubQueryTransformerCrossCore, TestRecovery, TestDefaultStatsCache, TestDynamicFieldResource, V2StandaloneTest, TestTolerantUpdateProcessorCloud, TestTrackingShardHandlerFactory, TestUtils, XsltUpdateRequestHandlerTest, TestMergePolicyConfig, DocExpirationUpdateProcessorFactoryTest, TestLegacyFieldReuse, TestFileDictionaryLookup, TestFilteredDocIdSet, DistanceUnitsTest, ReplicaListTransformerTest, RAMDirectoryFactoryTest, TestConfigSetImmutable, ChaosMonkeyNothingIsSafeWithPullReplicasTest, TestJmxIntegration, AliasIntegrationTest, TestScoreJoinQPScore, TestOverriddenPrefixQueryForCustomFieldType, SharedFSAutoReplicaFailoverUtilsTest, TestConfigsApi, TestReload, MergeStrategyTest, TestQueryUtils, TestSolr4Spatial2, MoveReplicaTest, SimplePostToolTest, TestBinaryResponseWriter, SuggesterTest, TestSQLHandler, TestInitQParser, DistributedFacetPivotWhiteBoxTest, FullSolrCloudDistribCmdsTest] [junit4] Completed [441/723 (4!)] on J2 in 2186.54s, 1 test, 1 error <<< FAILURES! [...truncated 962 lines...] [junit4] JVM J2: stdout was not empty, see: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/temp/junit4-J2-20170625_050840_9672767227006505942816.sysout [junit4] >>> JVM J2 emitted unexpected output (verbatim) ---- [junit4] java.lang.OutOfMemoryError: Java heap space [junit4] Dumping heap to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/heapdumps/java_pid8101.hprof ... [junit4] Heap dump file created [647524415 bytes in 3.953 secs] [junit4] <<< JVM J2: EOF ---- [...truncated 7485 lines...] BUILD FAILED /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/build.xml:818: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/build.xml:762: Some of the tests produced a heap dump, but did not fail. Maybe a suppressed OutOfMemoryError? Dumps created: * java_pid8101.hprof Total time: 249 minutes 42 seconds Build step 'Invoke Ant' marked build as failure Archiving 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
