Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.6-Linux/75/ Java: 64bit/jdk-12-ea+12 -XX:+UseCompressedOops -XX:+UseParallelGC
7 tests failed. FAILED: junit.framework.TestSuite.org.apache.solr.client.solrj.request.TestV2Request Error Message: 1 thread leaked from SUITE scope at org.apache.solr.client.solrj.request.TestV2Request: 1) Thread[id=177, name=Connection evictor, state=TIMED_WAITING, group=TGRP-TestV2Request] at java.base@12-ea/java.lang.Thread.sleep(Native Method) at app//org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66) at java.base@12-ea/java.lang.Thread.run(Thread.java:835) Stack Trace: com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.client.solrj.request.TestV2Request: 1) Thread[id=177, name=Connection evictor, state=TIMED_WAITING, group=TGRP-TestV2Request] at java.base@12-ea/java.lang.Thread.sleep(Native Method) at app//org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66) at java.base@12-ea/java.lang.Thread.run(Thread.java:835) at __randomizedtesting.SeedInfo.seed([5300DB420A857595]:0) FAILED: junit.framework.TestSuite.org.apache.solr.client.solrj.request.TestV2Request Error Message: 1 thread leaked from SUITE scope at org.apache.solr.client.solrj.request.TestV2Request: 1) Thread[id=479, name=Connection evictor, state=TIMED_WAITING, group=TGRP-TestV2Request] at java.base@12-ea/java.lang.Thread.sleep(Native Method) at app//org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66) at java.base@12-ea/java.lang.Thread.run(Thread.java:835) Stack Trace: com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.client.solrj.request.TestV2Request: 1) Thread[id=479, name=Connection evictor, state=TIMED_WAITING, group=TGRP-TestV2Request] at java.base@12-ea/java.lang.Thread.sleep(Native Method) at app//org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66) at java.base@12-ea/java.lang.Thread.run(Thread.java:835) at __randomizedtesting.SeedInfo.seed([5300DB420A857595]:0) FAILED: junit.framework.TestSuite.org.apache.solr.client.solrj.request.TestV2Request Error Message: 1 thread leaked from SUITE scope at org.apache.solr.client.solrj.request.TestV2Request: 1) Thread[id=958, name=Connection evictor, state=TIMED_WAITING, group=TGRP-TestV2Request] at java.base@12-ea/java.lang.Thread.sleep(Native Method) at app//org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66) at java.base@12-ea/java.lang.Thread.run(Thread.java:835) Stack Trace: com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.client.solrj.request.TestV2Request: 1) Thread[id=958, name=Connection evictor, state=TIMED_WAITING, group=TGRP-TestV2Request] at java.base@12-ea/java.lang.Thread.sleep(Native Method) at app//org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66) at java.base@12-ea/java.lang.Thread.run(Thread.java:835) at __randomizedtesting.SeedInfo.seed([5300DB420A857595]:0) FAILED: org.apache.solr.client.solrj.request.TestV2Request.testHttpSolrClient Error Message: Error from server at https://127.0.0.1:41765/solr: no such collection or alias Stack Trace: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteExecutionException: Error from server at https://127.0.0.1:41765/solr: no such collection or alias at __randomizedtesting.SeedInfo.seed([5300DB420A857595:8B18C368ABB167B2]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteExecutionException.create(HttpSolrClient.java:830) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:620) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1260) at org.apache.solr.client.solrj.request.TestV2Request.assertSuccess(TestV2Request.java:49) at org.apache.solr.client.solrj.request.TestV2Request.doTest(TestV2Request.java:96) at org.apache.solr.client.solrj.request.TestV2Request.testHttpSolrClient(TestV2Request.java:70) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:566) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1742) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985) 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:944) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891) 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 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.base/java.lang.Thread.run(Thread.java:835) FAILED: org.apache.solr.client.solrj.request.TestV2Request.testHttpSolrClient Error Message: Error from server at https://127.0.0.1:38861/solr: no such collection or alias Stack Trace: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteExecutionException: Error from server at https://127.0.0.1:38861/solr: no such collection or alias at __randomizedtesting.SeedInfo.seed([5300DB420A857595:8B18C368ABB167B2]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteExecutionException.create(HttpSolrClient.java:830) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:620) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1260) at org.apache.solr.client.solrj.request.TestV2Request.assertSuccess(TestV2Request.java:49) at org.apache.solr.client.solrj.request.TestV2Request.doTest(TestV2Request.java:96) at org.apache.solr.client.solrj.request.TestV2Request.testHttpSolrClient(TestV2Request.java:70) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:566) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1742) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985) 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:944) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891) 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 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.base/java.lang.Thread.run(Thread.java:835) FAILED: org.apache.solr.client.solrj.request.TestV2Request.testHttpSolrClient Error Message: Error from server at https://127.0.0.1:40283/solr: no such collection or alias Stack Trace: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteExecutionException: Error from server at https://127.0.0.1:40283/solr: no such collection or alias at __randomizedtesting.SeedInfo.seed([5300DB420A857595:8B18C368ABB167B2]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteExecutionException.create(HttpSolrClient.java:830) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:620) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1260) at org.apache.solr.client.solrj.request.TestV2Request.assertSuccess(TestV2Request.java:49) at org.apache.solr.client.solrj.request.TestV2Request.doTest(TestV2Request.java:96) at org.apache.solr.client.solrj.request.TestV2Request.testHttpSolrClient(TestV2Request.java:70) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:566) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1742) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985) 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:944) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891) 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 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.base/java.lang.Thread.run(Thread.java:835) FAILED: org.apache.solr.handler.component.DistributedDebugComponentTest.testDebugSections Error Message: Error from server at https://127.0.0.1:37075/solr/collection1: org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: https://127.0.0.1:37075/solr/collection2 Stack Trace: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:37075/solr/collection1: org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: https://127.0.0.1:37075/solr/collection2 at __randomizedtesting.SeedInfo.seed([85A97E3967E2B3AD:74F231299C52AF05]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:643) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194) at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:983) at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:998) at org.apache.solr.handler.component.DistributedDebugComponentTest.verifyDebugSections(DistributedDebugComponentTest.java:269) at org.apache.solr.handler.component.DistributedDebugComponentTest.testDebugSections(DistributedDebugComponentTest.java:260) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:566) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1742) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985) 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:944) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891) 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 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.base/java.lang.Thread.run(Thread.java:835) Build Log: [...truncated 13549 lines...] [junit4] Suite: org.apache.solr.handler.component.DistributedDebugComponentTest [junit4] 2> 852847 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-7.6-Linux/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest_85A97E3967E2B3AD-001/init-core-data-001 [junit4] 2> 852848 WARN (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1 [junit4] 2> 852848 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 852848 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0) [junit4] 2> 852855 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 852855 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 852856 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-7.6-Linux/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest_85A97E3967E2B3AD-001/tempDir-002/cores/core [junit4] 2> 852871 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 12-ea+12 [junit4] 2> 852876 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 852876 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 852876 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 852876 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6e7aa8e7{/solr,null,AVAILABLE} [junit4] 2> 852878 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.e.j.s.AbstractConnector Started ServerConnector@582f338a{SSL,[ssl, http/1.1]}{127.0.0.1:37075} [junit4] 2> 852878 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.e.j.s.Server Started @852908ms [junit4] 2> 852878 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, configSetBaseDir=/home/jenkins/workspace/Lucene-Solr-7.6-Linux/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest_85A97E3967E2B3AD-001/tempDir-001, hostPort=37075, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-7.6-Linux/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest_85A97E3967E2B3AD-001/tempDir-002/cores} [junit4] 2> 852879 ERROR (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 852879 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 852879 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.6.0 [junit4] 2> 852879 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 852879 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 852879 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-12-08T05:30:31.978192Z [junit4] 2> 852879 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-7.6-Linux/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest_85A97E3967E2B3AD-001/tempDir-001/solr.xml [junit4] 2> 852880 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 852880 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 852881 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@38286ca, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 852956 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 852956 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 852965 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@38286ca [junit4] 2> 852970 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@38286ca [junit4] 2> 852970 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@38286ca [junit4] 2> 852971 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.6-Linux/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest_85A97E3967E2B3AD-001/tempDir-002/cores [junit4] 2> 852971 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 852979 INFO (coreLoadExecutor-2220-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.6.0 [junit4] 2> 852995 INFO (coreLoadExecutor-2220-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 853052 INFO (coreLoadExecutor-2220-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 853057 INFO (coreLoadExecutor-2220-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/workspace/Lucene-Solr-7.6-Linux/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest_85A97E3967E2B3AD-001/tempDir-001/collection1, trusted=true [junit4] 2> 853058 INFO (coreLoadExecutor-2220-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@38286ca [junit4] 2> 853058 INFO (coreLoadExecutor-2220-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.6-Linux/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest_85A97E3967E2B3AD-001/tempDir-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-7.6-Linux/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest_85A97E3967E2B3AD-001/tempDir-002/cores/core/data/] [junit4] 2> 853059 INFO (coreLoadExecutor-2220-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=2, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.16990898687207706] [junit4] 2> 853087 INFO (coreLoadExecutor-2220-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 853087 INFO (coreLoadExecutor-2220-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 853087 INFO (coreLoadExecutor-2220-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 853087 INFO (coreLoadExecutor-2220-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 853088 INFO (coreLoadExecutor-2220-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=21, maxMergeAtOnceExplicit=28, maxMergedSegmentMB=10.9453125, floorSegmentMB=0.796875, forceMergeDeletesPctAllowed=9.14882621391814, segmentsPerTier=15.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, deletesPctAllowed=45.538307674586086 [junit4] 2> 853088 INFO (coreLoadExecutor-2220-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@392963c2[collection1] main] [junit4] 2> 853089 INFO (coreLoadExecutor-2220-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 853146 INFO (coreLoadExecutor-2220-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 853228 INFO (coreLoadExecutor-2220-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 853228 INFO (searcherExecutor-2221-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 853228 INFO (coreLoadExecutor-2220-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1619260376169316352 [junit4] 2> 853228 INFO (searcherExecutor-2221-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 853228 INFO (searcherExecutor-2221-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 853228 INFO (searcherExecutor-2221-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 853228 INFO (searcherExecutor-2221-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 853228 INFO (searcherExecutor-2221-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 853229 INFO (searcherExecutor-2221-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 853229 INFO (searcherExecutor-2221-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 853229 INFO (searcherExecutor-2221-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 853229 INFO (SUITE-DistributedDebugComponentTest-seed#[85A97E3967E2B3AD]-worker) [ ] o.a.s.SolrJettyTestBase Jetty Assigned Port#37075 [junit4] 2> 853229 INFO (searcherExecutor-2221-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@392963c2[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 853245 INFO (qtp595677912-4368) [ x:collection2] o.a.s.h.a.CoreAdminOperation core create command name=collection2&action=CREATE&configSet=collection1&wt=javabin&version=2 [junit4] 2> 853259 INFO (qtp595677912-4368) [ x:collection2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.6.0 [junit4] 2> 853274 INFO (qtp595677912-4368) [ x:collection2] o.a.s.s.IndexSchema [collection2] Schema name=test [junit4] 2> 853328 INFO (qtp595677912-4368) [ x:collection2] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 853334 INFO (qtp595677912-4368) [ x:collection2] o.a.s.c.CoreContainer Creating SolrCore 'collection2' using configuration from configset /home/jenkins/workspace/Lucene-Solr-7.6-Linux/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest_85A97E3967E2B3AD-001/tempDir-001/collection1, trusted=true [junit4] 2> 853334 INFO (qtp595677912-4368) [ x:collection2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection2' (registry 'solr.core.collection2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@38286ca [junit4] 2> 853335 INFO (qtp595677912-4368) [ x:collection2] o.a.s.c.SolrCore [[collection2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.6-Linux/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest_85A97E3967E2B3AD-001/tempDir-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-7.6-Linux/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest_85A97E3967E2B3AD-001/tempDir-002/cores/collection2/data/] [junit4] 2> 853336 INFO (qtp595677912-4368) [ x:collection2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=2, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.16990898687207706] [junit4] 2> 853369 INFO (qtp595677912-4368) [ x:collection2] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 853369 INFO (qtp595677912-4368) [ x:collection2] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 853370 INFO (qtp595677912-4368) [ x:collection2] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 853370 INFO (qtp595677912-4368) [ x:collection2] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 853370 INFO (qtp595677912-4368) [ x:collection2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=21, maxMergeAtOnceExplicit=28, maxMergedSegmentMB=10.9453125, floorSegmentMB=0.796875, forceMergeDeletesPctAllowed=9.14882621391814, segmentsPerTier=15.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, deletesPctAllowed=45.538307674586086 [junit4] 2> 853371 INFO (qtp595677912-4368) [ x:collection2] o.a.s.s.SolrIndexSearcher Opening [Searcher@1e98230d[collection2] main] [junit4] 2> 853371 INFO (qtp595677912-4368) [ x:collection2] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 853388 INFO (qtp595677912-4368) [ x:collection2] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 853472 INFO (qtp595677912-4368) [ x:collection2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 853472 INFO (searcherExecutor-2226-thread-1-processing-x:collection2) [ x:collection2] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 853472 INFO (qtp595677912-4368) [ x:collection2] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1619260376425168896 [junit4] 2> 853472 INFO (searcherExecutor-2226-thread-1-processing-x:collection2) [ x:collection2] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 853472 INFO (searcherExecutor-2226-thread-1-processing-x:collection2) [ x:collection2] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 853472 INFO (searcherExecutor-2226-thread-1-processing-x:collection2) [ x:collection2] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 853472 INFO (searcherExecutor-2226-thread-1-processing-x:collection2) [ x:collection2] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 853472 INFO (searcherExecutor-2226-thread-1-processing-x:collection2) [ x:collection2] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 853473 INFO (searcherExecutor-2226-thread-1-processing-x:collection2) [ x:collection2] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 853473 INFO (searcherExecutor-2226-thread-1-processing-x:collection2) [ x:collection2] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 853473 INFO (searcherExecutor-2226-thread-1-processing-x:collection2) [ x:collection2] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 853473 INFO (searcherExecutor-2226-thread-1-processing-x:collection2) [ x:collection2] o.a.s.c.SolrCore [collection2] Registered new searcher Searcher@1e98230d[collection2] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 853473 INFO (qtp595677912-4368) [ x:collection2] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={name=collection2&action=CREATE&configSet=collection1&wt=javabin&version=2} status=0 QTime=228 [junit4] 2> 853489 INFO (qtp595677912-4369) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[1 (1619260376441946112)]} 0 1 [junit4] 2> 853490 INFO (qtp595677912-4367) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1619260376444043264,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 853490 INFO (qtp595677912-4367) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@13806f57 commitCommandVersion:1619260376444043264 [junit4] 2> 853492 INFO (qtp595677912-4367) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1e98f157[collection1] main] [junit4] 2> 853492 INFO (qtp595677912-4367) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 853493 INFO (searcherExecutor-2221-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1e98f157[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.6.0):C1)))} [junit4] 2> 853493 INFO (qtp595677912-4367) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 3 [junit4] 2> 853504 INFO (qtp595677912-4367) [ x:collection2] o.a.s.u.p.LogUpdateProcessorFactory [collection2] webapp=/solr path=/update params={wt=javabin&version=2}{add=[2 (1619260376457674752)]} 0 0 [junit4] 2> 853505 INFO (qtp595677912-4387) [ x:collection2] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1619260376459771904,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 853505 INFO (qtp595677912-4387) [ x:collection2] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@291c7746 commitCommandVersion:1619260376459771904 [junit4] 2> 853506 INFO (qtp595677912-4387) [ x:collection2] o.a.s.s.SolrIndexSearcher Opening [Searcher@6ade603b[collection2] main] [junit4] 2> 853507 INFO (qtp595677912-4387) [ x:collection2] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 853508 INFO (searcherExecutor-2226-thread-1-processing-x:collection2) [ x:collection2] o.a.s.c.SolrCore [collection2] Registered new searcher Searcher@6ade603b[collection2] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.6.0):C1)))} [junit4] 2> 853508 INFO (qtp595677912-4387) [ x:collection2] o.a.s.u.p.LogUpdateProcessorFactory [collection2] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 3 [junit4] IGNOR/A 0.00s J0 | DistributedDebugComponentTest.testCompareWithNonDistributedRequest [junit4] > Assumption #1: 'badapple' test group is disabled (@BadApple(bugUrl="https://issues.apache.org/jira/browse/SOLR-12028")) [junit4] 2> 853511 INFO (TEST-DistributedDebugComponentTest.testDebugSections-seed#[85A97E3967E2B3AD]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testDebugSections [junit4] 2> 853518 ERROR (qtp595677912-4369) [ x:collection1] o.a.s.h.RequestHandlerBase org.apache.solr.common.SolrException: org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: https://127.0.0.1:37075/solr/collection2 [junit4] 2> at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:413) [junit4] 2> at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:199) [junit4] 2> at org.apache.solr.core.SolrCore.execute(SolrCore.java:2541) [junit4] 2> at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:709) [junit4] 2> at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:515) [junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:377) [junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:323) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1642) [junit4] 2> at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1642) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:533) [junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255) [junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1595) [junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255) [junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1317) [junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:203) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:473) [junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1564) [junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:201) [junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1219) [junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:144) [junit4] 2> at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:724) [junit4] 2> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132) [junit4] 2> at org.eclipse.jetty.server.Server.handle(Server.java:531) [junit4] 2> at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:352) [junit4] 2> at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:260) [junit4] 2> at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:281) [junit4] 2> at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:102) [junit4] 2> at org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:291) [junit4] 2> at org.eclipse.jetty.io.ssl.SslConnection$3.succeeded(SslConnection.java:151) [junit4] 2> at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:102) [junit4] 2> at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:118) [junit4] 2> at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.runTask(EatWhatYouKill.java:333) [junit4] 2> at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:310) [junit4] 2> at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:168) [junit4] 2> at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:126) [junit4] 2> at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:366) [junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:762) [junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:680) [junit4] 2> at java.base/java.lang.Thread.run(Thread.java:835) [junit4] 2> Caused by: org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: https://127.0.0.1:37075/solr/collection2 [junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:657) [junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255) [junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244) [junit4] 2> at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1260) [junit4] 2> at org.apache.solr.handler.component.HttpShardHandler.lambda$submit$0(HttpShardHandler.java:172) [junit4] 2> at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) [junit4] 2> at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515) [junit4] 2> at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) [junit4] 2> at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209) [junit4] 2> at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) [junit4] 2> at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) [junit4] 2> ... 1 more [junit4] 2> Caused by: javax.net.ssl.SSLException: Received fatal alert: internal_error [junit4] 2> at java.base/sun.security.ssl.Alert.createSSLException(Alert.java:129) [junit4] 2> at java.base/sun.security.ssl.Alert.createSSLException(Alert.java:117) [junit4] 2> at java.base/sun.security.ssl.TransportContext.fatal(TransportContext.java:308) [junit4] 2> at java.base/sun.security.ssl.Alert$AlertConsumer.consume(Alert.java:279) [junit4] 2> at java.base/sun.security.ssl.TransportContext.dispatch(TransportContext.java:181) [junit4] 2> at java.base/sun.security.ssl.SSLTransport.decode(SSLTransport.java:164) [junit4] 2> at java.base/sun.security.ssl.SSLSocketImpl.decode(SSLSocketImpl.java:1152) [junit4] 2> at java.base/sun.security.ssl.SSLSocketImpl.readHandshakeRecord(SSLSocketImpl.java:1063) [junit4] 2> at java.base/sun.security.ssl.SSLSocketImpl.startHandshake(SSLSocketImpl.java:402) [junit4] 2> at org.apache.http.conn.ssl.SSLConnectionSocketFactory.createLayeredSocket(SSLConnectionSocketFactory.java:396) [junit4] 2> at org.apache.http.conn.ssl.SSLConnectionSocketFactory.connectSocket(SSLConnectionSocketFactory.java:355) [junit4] 2> at org.apache.http.impl.conn.DefaultHttpClientConnectionOperator.connect(DefaultHttpClientConnectionOperator.java:142) [junit4] 2> at org.apache.http.impl.conn.PoolingHttpClientConnectionManager.connect(PoolingHttpClientConnectionManager.java:359) [junit4] 2> at org.apache.http.impl.execchain.MainClientExec.establishRoute(MainClientExec.java:381) [junit4] 2> at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:237) [junit4] 2> at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:185) [junit4] 2> at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89) [junit4] 2> at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:111) [junit4] 2> at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185) [junit4] 2> at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83) [junit4] 2> at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56) [junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:542) [junit4] 2> ... 12 more [junit4] 2> [junit4] 2> 853518 INFO (qtp595677912-4369) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=text:_query_with_no_results_&shards=127.0.0.1:37075/solr/collection1,127.0.0.1:37075/solr/collection2&distrib=true&fl=id,text&wt=javabin&version=2&debugQuery=true} rid=127.0.0.1-collection1-1544247032611-0 status=500 QTime=6 [junit4] 2> 853518 ERROR (qtp595677912-4369) [ x:collection1] o.a.s.s.HttpSolrCall null:org.apache.solr.common.SolrException: org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: https://127.0.0.1:37075/solr/collection2 [junit4] 2> at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:413) [junit4] 2> at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:199) [junit4] 2> at org.apache.solr.core.SolrCore.execute(SolrCore.java:2541) [junit4] 2> at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:709) [junit4] 2> at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:515) [junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:377) [junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:323) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1642) [junit4] 2> at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1642) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:533) [junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255) [junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1595) [junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255) [junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1317) [junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:203) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:473) [junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1564) [junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:201) [junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1219) [junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:144) [junit4] 2> at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:724) [junit4] 2> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132) [junit4] 2> at org.eclipse.jetty.server.Server.handle(Server.java:531) [junit4] 2> at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:352) [junit4] 2> at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:260) [junit4] 2> at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:281) [junit4] 2> at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:102) [junit4] 2> at org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:291) [junit4] 2> at org.eclipse.jetty.io.ssl.SslConnection$3.succeeded(SslConnection.java:151) [junit4] 2> at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:102) [junit4] 2> at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:118) [junit4] 2> at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.runTask(EatWhatYouKill.java:333) [junit4] 2> at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:310) [junit4] 2> at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:168) [junit4] 2> at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:126) [junit4] 2> at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:366) [junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:762) [junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:680) [junit4] 2> at java.base/java.lang.Thread.run(Thread.java:835) [junit4] 2> Caused by: org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: https://127.0.0.1:37075/solr/collection2 [junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:657) [junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255) [junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244) [junit4] 2> at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1260) [junit4] 2> at org.apache.solr.handler.component.HttpShardHandler.lambda$submit$0(HttpShardHandler.java:172) [junit4] 2> at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) [junit4] 2> at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515) [junit4] 2> at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) [junit4] 2> at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209) [junit4] 2> at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) [junit4] 2> at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) [junit4] 2> ... 1 more [junit4] 2> Caused by: javax.net.ssl.SSLException: Received fatal alert: internal_error [junit4] 2> at java.base/sun.security.ssl.Alert.createSSLException(Alert.java:129) [junit4] 2> at java.base/sun.security.ssl.Alert.createSSLException(Alert.java:117) [junit4] 2> at java.base/sun.security.ssl.TransportContext.fatal(TransportContext.java:308) [junit4] 2> at java.base/sun.security.ssl.Alert$AlertConsumer.consume(Alert.java:279) [junit4] 2> at java.base/sun.security.ssl.TransportContext.dispatch(TransportContext.java:181) [junit4] 2> at java.base/sun.security.ssl.SSLTransport.decode(SSLTransport.java:164) [junit4] 2> at java.base/sun.security.ssl.SSLSocketImpl.decode(SSLSocketImpl.java:1152) [junit4] 2> at java.base/sun.security.ssl.SSLSocketImpl.readHandshakeRecord(SSLSocketImpl.java:1063) [junit4] 2> at java.base/sun.security.ssl.SSLSocketImpl.startHandshake(SSLSocketImpl.java:402) [junit4] 2> at org.apache.http.conn.ssl.SSLConnectionSocketFactory.createLayeredSocket(SSLConnectionSocketFactory.java:396) [junit4] 2> at org.apache.http.conn.ssl.SSLConnectionSocketFactory.connectSocket(SSLConnectionSocketFactory.java:355) [junit4] 2> at org.apache.http.impl.conn.DefaultHttpClientConnectionOperator.connect(DefaultHttpClientConnectionOperator.java:142) [junit4] 2> at org.apache.http.impl.conn.PoolingHttpClientConnectionManager.connect(PoolingHttpClientConnectionManager.java:359) [junit4] 2> at org.apache.http.impl.execchain.MainClientExec.establishRoute(MainClientExec.java:381) [junit4] 2> at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:237) [junit4] 2> at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:185) [junit4] 2> at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89) [junit4] 2> at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:111) [junit4] 2> at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185) [junit4] 2> at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83) [junit4] 2> at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56) [junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:542) [junit4] 2> ... 12 more [junit4] 2> [junit4] 2> 853520 INFO (TEST-DistributedDebugComponentTest.testDebugSections-seed#[85A97E3967E2B3AD]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testDebugSections [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=DistributedDebugComponentTest -Dtests.method=testDebugSections -Dtests.seed=85A97E3967E2B3AD -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=yue-Hans -Dtests.timezone=Europe/Copenhagen -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [junit4] ERROR 0.01s J0 | DistributedDebugComponentTest.testDebugSections <<< [junit4] > Throwable #1: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:37075/solr/collection1: org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: https://127.0.0.1:37075/solr/collection2 [junit4] > at __randomizedtesting.SeedInfo.seed([85A97E3967E2B3AD:74F231299C52AF05]:0) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:643) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244) [junit4] > at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194) [junit4] > at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:983) [junit4] > at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:998) [junit4] > at org.apache.solr.handler.component.DistributedDebugComponentTest.verifyDebugSections(DistributedDebugComponentTest.java:269) [junit4] > at org.apache.solr.handler.component.DistributedDebugComponentTest.testDebugSections(DistributedDebugComponentTest.java:260) [junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] > at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] > at java.base/java.lang.reflect.Method.invoke(Method.java:566) [junit4] > at java.base/java.lang.Thread.run(Thread.java:835) [junit4] 2> 853525 INFO (TEST-DistributedDebugComponentTest.testSimpleSearch-seed#[85A97E3967E2B3AD]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testSimpleSearch [junit4] 2> 853526 INFO (qtp595677912-4364) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:37075/solr/collection1&rid=127.0.0.1-collection1-1544247032611-0&rows=10&version=2&q=text:_query_with_no_results_&requestPurpose=GET_TOP_IDS&NOW=1544247032611&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=1 [junit4] 2> 853527 INFO (qtp595677912-4369) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:37075/solr/collection1&rid=127.0.0.1-collection1-1544247032625-1&rows=10&version=2&q=*:*&requestPurpose=GET_TOP_IDS&NOW=1544247032625&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 853537 INFO (qtp595677912-4368) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:37075/solr/collection2&rid=127.0.0.1-collection1-1544247032625-1&rows=10&version=2&q=*:*&requestPurpose=GET_TOP_IDS&NOW=1544247032625&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 853539 INFO (qtp595677912-4364) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=track&debug=track&fl=id,text&shards.purpose=320&shard.url=127.0.0.1:37075/solr/collection2&rid=127.0.0.1-collection1-1544247032625-1&version=2&q=*:*&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1544247032625&ids=2&isShard=true&wt=javabin} status=0 QTime=0 [junit4] 2> 853539 INFO (qtp595677912-4369) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=track&debug=track&fl=id,text&shards.purpose=320&shard.url=127.0.0.1:37075/solr/collection1&rid=127.0.0.1-collection1-1544247032625-1&version=2&q=*:*&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1544247032625&ids=1&isShard=true&wt=javabin} status=0 QTime=0 [junit4] 2> 853539 INFO (qtp595677912-4387) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=*:*&shards=127.0.0.1:37075/solr/collection1,127.0.0.1:37075/solr/collection2&distrib=true&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1544247032625-1 hits=2 status=0 QTime=13 [junit4] 2> 853541 INFO (qtp595677912-4363) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:37075/solr/collection1&rid=127.0.0.1-collection1-1544247032639-2&rows=10&version=2&q=*:*&omitHeader=true&requestPurpose=GET_TOP_IDS&NOW=1544247032639&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 853541 INFO (qtp595677912-4387) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:37075/solr/collection2&rid=127.0.0.1-collection1-1544247032639-2&rows=10&version=2&q=*:*&omitHeader=true&requestPurpose=GET_TOP_IDS&NOW=1544247032639&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 853542 INFO (qtp595677912-4369) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=track&debug=track&fl=id,text&shards.purpose=320&shard.url=127.0.0.1:37075/solr/collection2&rid=127.0.0.1-collection1-1544247032639-2&version=2&q=*:*&omitHeader=true&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1544247032639&ids=2&isShard=true&wt=javabin} status=0 QTime=0 [junit4] 2> 853542 INFO (qtp595677912-4364) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=track&debug=track&fl=id,text&shards.purpose=320&shard.url=127.0.0.1:37075/solr/collection1&rid=127.0.0.1-collection1-1544247032639-2&version=2&q=*:*&omitHeader=true&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1544247032639&ids=1&isShard=true&wt=javabin} status=0 QTime=0 [junit4] 2> 853543 INFO (qtp595677912-4368) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=*:*&shards=127.0.0.1:37075/solr/collection1,127.0.0.1:37075/solr/collection2&distrib=true&debug=track&omitHeader=true&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1544247032639-2 hits=2 status=0 QTime=2 [junit4] 2> 853544 INFO (qtp595677912-4369) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:37075/solr/collection2&rid=127.0.0.1-collection1-1544247032642-3&rows=10&version=2&q=id:1&omitHeader=true&requestPurpose=GET_TOP_IDS&NOW=1544247032642&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 853544 INFO (qtp595677912-4368) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:37075/solr/collection1&rid=127.0.0.1-collection1-1544247032642-3&rows=10&version=2&q=id:1&omitHeader=true&requestPurpose=GET_TOP_IDS&NOW=1544247032642&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 853545 INFO (qtp595677912-4364) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=track&debug=track&fl=id,text&shards.purpose=320&shard.url=127.0.0.1:37075/solr/collection1&rid=127.0.0.1-collection1-1544247032642-3&version=2&q=id:1&omitHeader=true&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1544247032642&ids=1&isShard=true&wt=javabin} status=0 QTime=0 [junit4] 2> 853545 INFO (qtp595677912-4387) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=id:1&shards=127.0.0.1:37075/solr/collection1,127.0.0.1:37075/solr/collection2&distrib=true&debug=track&omitHeader=true&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1544247032642-3 hits=1 status=0 QTime=2 [junit4] 2> 853546 INFO (TEST-DistributedDebugComponentTest.testSimpleSearch-seed#[85A97E3967E2B3AD]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testSimpleSearch [junit4] 2> 853549 INFO (TEST-DistributedDebugComponentTest.testRandom-seed#[85A97E3967E2B3AD]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testRandom [junit4] 2> 853552 INFO (qtp595677912-4368) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:37075/solr/collection2&rows=10&version=2&q=_query_with_no_results_+OR+superman&NOW=1544247032650&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 853553 INFO (qtp595677912-4364) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&distrib=false&df=text&debug=query&debug=query&fl=id,text&shards.purpose=320&NOW=1544247032650&ids=2&isShard=true&shard.url=127.0.0.1:37075/solr/collection2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 853554 INFO (qtp595677912-4367) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&shards=127.0.0.1:37075/solr/collection2&distrib=true&debug=query&fl=id,text&wt=javabin&version=2} hits=1 status=0 QTime=2 [junit4] 2> 853555 INFO (qtp595677912-4367) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:37075/solr/collection2&rid=127.0.0.1-collection1-1544247032653-4&rows=10&version=2&q=_query_with_no_results_&requestPurpose=GET_TOP_IDS&NOW=1544247032653&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 853555 INFO (qtp595677912-4368) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_&shards=127.0.0.1:37075/solr/collection2&distrib=true&debug=query&debug=results&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1544247032653-4 hits=0 status=0 QTime=1 [junit4] 2> 853557 INFO (qtp595677912-4368) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:37075/solr/collection2&rows=10&version=2&q=_query_with_no_results_+OR+superman&NOW=1544247032655&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 853558 INFO (qtp595677912-4367) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&distrib=false&df=text&debug=query&debug=query&fl=id,text&shards.purpose=320&NOW=1544247032655&ids=2&isShard=true&shard.url=127.0.0.1:37075/solr/collection2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 853558 INFO (qtp595677912-4364) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&shards=127.0.0.1:37075/solr/collection2&distrib=true&debug=query&fl=id,text&wt=javabin&version=2} hits=1 status=0 QTime=2 [junit4] 2> 853560 INFO (qtp595677912-4368) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:37075/solr/collection2&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&NOW=1544247032658&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 853561 INFO (qtp595677912-4367) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&distrib=false&df=text&debug=results&debug=results&fl=id,text&shards.purpose=320&NOW=1544247032658&ids=2&isShard=true&shard.url=127.0.0.1:37075/solr/collection2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 853561 INFO (qtp595677912-4387) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:37075/solr/collection2&distrib=true&debug=results&fl=id,text&wt=javabin&version=2} hits=1 status=0 QTime=2 [junit4] 2> 853563 INFO (qtp595677912-4387) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:37075/solr/collection2&rid=127.0.0.1-collection1-1544247032661-5&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1544247032661&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 853564 INFO (qtp595677912-4367) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=query&debug=track&debug=query&debug=track&fl=id,text&shards.purpose=320&shard.url=127.0.0.1:37075/solr/collection2&rid=127.0.0.1-collection1-1544247032661-5&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1544247032661&ids=2&isShard=true&wt=javabin} status=0 QTime=0 [junit4] 2> 853565 INFO (qtp595677912-4368) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:37075/solr/collection2&distrib=true&debug=query&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1544247032661-5 hits=1 status=0 QTime=2 [junit4] 2> 853569 INFO (qtp595677912-4387) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:37075/solr/collection2&rid=127.0.0.1-collection2-1544247032667-6&rows=10&version=2&q=_query_with_no_results_+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1544247032667&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 853569 INFO (qtp595677912-4363) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:37075/solr/collection1&rid=127.0.0.1-collection2-1544247032667-6&rows=10&version=2&q=_query_with_no_results_+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1544247032667&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 853570 INFO (qtp595677912-4369) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=results&debug=track&debug=results&debug=track&fl=id,text&shards.purpose=320&shard.url=127.0.0.1:37075/solr/collection2&rid=127.0.0.1-collection2-1544247032667-6&version=2&q=_query_with_no_results_+OR+superman&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1544247032667&ids=2&isShard=true&wt=javabin} status=0 QTime=0 [junit4] 2> 853570 INFO (qtp595677912-4364) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&shards=127.0.0.1:37075/solr/collection2,127.0.0.1:37075/solr/collection1&distrib=true&debug=results&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1544247032667-6 hits=1 status=0 QTime=2 [junit4] 2> 853572 INFO (qtp595677912-4364) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:37075/solr/collection2&rid=127.0.0.1-collection1-1544247032670-7&rows=10&version=2&q=_query_with_no_results_&requestPurpose=GET_TOP_IDS&NOW=1544247032670&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 853572 INFO (qtp595677912-4363) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:37075/solr/collection1&rid=127.0.0.1-collection1-1544247032670-7&rows=10&version=2&q=_query_with_no_results_&requestPurpose=GET_TOP_IDS&NOW=1544247032670&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 853572 INFO (qtp595677912-4367) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_&shards=127.0.0.1:37075/solr/collection2,127.0.0.1:37075/solr/collection1&distrib=true&debug=results&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1544247032670-7 hits=0 status=0 QTime=1 [junit4] 2> 853573 INFO (qtp595677912-4369) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:37075/solr/collection2&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&NOW=1544247032671&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 853574 INFO (qtp595677912-4363) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&distrib=false&df=text&debug=query&debug=query&fl=id,text&shards.purpose=320&NOW=1544247032671&ids=2&isShard=true&shard.url=127.0.0.1:37075/solr/collection2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 853574 INFO (qtp595677912-4368) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:37075/solr/collection2&distrib=true&debug=query&fl=id,text&wt=javabin&version=2} hits=1 status=0 QTime=2 [junit4] 2> 853576 INFO (qtp595677912-4369) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:37075/solr/collection2&rid=127.0.0.1-collection2-1544247032674-8&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1544247032674&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 853577 INFO (qtp595677912-4363) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=timing&debug=track&debug=timing&debug=track&fl=id,text&shards.purpose=320&shard.url=127.0.0.1:37075/solr/collection2&rid=127.0.0.1-collection2-1544247032674-8&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1544247032674&ids=2&isShard=true&wt=javabin} status=0 QTime=0 [junit4] 2> 853577 INFO (qtp595677912-4367) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:37075/solr/collection2&distrib=true&debug=timing&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1544247032674-8 hits=1 status=0 QTime=2 [junit4] 2> 853579 INFO (qtp595677912-4367) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:37075/solr/collection2&rows=10&version=2&q=_query_with_no_results_+OR+superman&NOW=1544247032677&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 853580 INFO (qtp595677912-4363) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&distrib=false&df=text&debug=results&debug=results&fl=id,text&shards.purpose=320&NOW=1544247032677&ids=2&isShard=true&shard.url=127.0.0.1:37075/solr/collection2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 853580 INFO (qtp595677912-4369) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&shards=127.0.0.1:37075/solr/collection2&distrib=true&debug=results&fl=id,text&wt=javabin&version=2} hits=1 status=0 QTime=2 [junit4] 2> 853582 INFO (qtp595677912-4387) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:37075/solr/collection1&rid=127.0.0.1-collection2-1544247032680-9&rows=10&version=2&q=_query_with_no_results_+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1544247032680&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 853582 INFO (qtp595677912-4367) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:37075/solr/collection2&rid=127.0.0.1-collection2-1544247032680-9&rows=10&version=2&q=_query_with_no_results_+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1544247032680&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 853583 INFO (qtp595677912-4363) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=timing&debug=query&debug=results&debug=track&debug=timing&debug=track&fl=id,text&shards.purpose=320&shard.url=127.0.0.1:37075/solr/collection2&rid=127.0.0.1-collection2-1544247032680-9&version=2&q=_query_with_no_results_+OR+superman&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1544247032680&ids=2&isShard=true&wt=javabin&debugQuery=true} status=0 QTime=0 [junit4] 2> 853583 INFO (qtp595677912-4368) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&shards=127.0.0.1:37075/solr/collection2,127.0.0.1:37075/solr/collection1&distrib=true&debug=timing&debug=query&debug=results&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1544247032680-9 hits=1 status=0 QTime=2 [junit4] 2> 853585 INFO (qtp595677912-4368) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:37075/solr/collection1&rid=127.0.0.1-collection1-1544247032683-10&rows=10&version=2&q=_query_with_no_results_+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1544247032683&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 853585 INFO (qtp595677912-4387) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&shards=127.0.0.1:37075/solr/collection1&distrib=true&debug=query&debug=results&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1544247032683-10 hits=0 status=0 QTime=1 [junit4] 2> 853586 INFO (qtp595677912-4363) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:37075/solr/collection2&rid=127.0.0.1-collection2-1544247032685-11&rows=10&version=2&q=_query_with_no_results_&requestPurpose=GET_TOP_IDS&NOW=1544247032684&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 853587 INFO (qtp595677912-4369) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_&shards=127.0.0.1:37075/solr/collection2&distrib=true&debug=timing&debug=query&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1544247032685-11 hits=0 status=0 QTime=1 [junit4] 2> 853588 INFO (qtp595677912-4369) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:37075/solr/collection2&rows=10&version=2&q=_query_with_no_results_&NOW=1544247032686&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 853588 INFO (qtp595677912-4368) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_&shards=127.0.0.1:37075/solr/collection2&distrib=true&debug=query&debug=results&fl=id,text&wt=javabin&version=2} hits=0 status=0 QTime=1 [junit4] 2> 853590 INFO (qtp595677912-4363) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:37075/solr/collection1&rid=127.0.0.1-collection2-1544247032688-12&rows=10&version=2&q=_query_with_no_results_&requestPurpose=GET_TOP_IDS&NOW=1544247032688&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 853590 INFO (qtp595677912-4387) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_&shards=127.0.0.1:37075/solr/collection1&distrib=true&debug=query&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1544247032688-12 hits=0 status=0 QTime=1 [junit4] 2> 853592 INFO (qtp595677912-4364) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:37075/solr/collection1&rid=127.0.0.1-collection1-1544247032690-13&rows=10&version=2&q=_query_with_no_results_+OR+batman&requestPurpose=GET_TOP_IDS&NOW=1544247032690&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 853593 INFO (qtp595677912-4387) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:37075/solr/coll [...truncated too long message...] compile-lucene-core: init: -clover.disable: -clover.load: -clover.classpath: -clover.setup: clover: compile-core: -clover.disable: -clover.load: -clover.classpath: -clover.setup: clover: common.compile-core: compile-core: common.compile-test: [mkdir] Created dir: /home/jenkins/workspace/Lucene-Solr-7.6-Linux/solr/build/solr-core/classes/test [javac] Compiling 934 source files to /home/jenkins/workspace/Lucene-Solr-7.6-Linux/solr/build/solr-core/classes/test [javac] Note: Some input files use or override a deprecated API. [javac] Note: Recompile with -Xlint:deprecation for details. [javac] Note: Some input files use unchecked or unsafe operations. [javac] Note: Recompile with -Xlint:unchecked for details. [javac] Creating empty /home/jenkins/workspace/Lucene-Solr-7.6-Linux/solr/build/solr-core/classes/test/org/apache/solr/cloud/autoscaling/sim/package-info.class [copy] Copying 1 file to /home/jenkins/workspace/Lucene-Solr-7.6-Linux/solr/build/solr-core/classes/test common-solr.compile-test: compile-test: BUILD SUCCESSFUL Total time: 24 seconds [repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.DistributedDebugComponentTest" -Dtests.showOutput=onerror "-Dargs=-XX:+UseCompressedOops -XX:+UseParallelGC" -Dtests.seed=85A97E3967E2B3AD -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=yue-Hans -Dtests.timezone=Europe/Copenhagen -Dtests.asserts=true -Dtests.file.encoding=US-ASCII Buildfile: /home/jenkins/workspace/Lucene-Solr-7.6-Linux/solr/core/build.xml -clover.disable: ivy-configure: [ivy:configure] :: Apache Ivy 2.4.0 - 20141213170938 :: http://ant.apache.org/ivy/ :: [ivy:configure] :: loading settings :: file = /home/jenkins/workspace/Lucene-Solr-7.6-Linux/lucene/top-level-ivy-settings.xml install-junit4-taskdef: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: resolve-groovy: [ivy:cachepath] :: resolving dependencies :: org.codehaus.groovy#groovy-all-caller;working [ivy:cachepath] confs: [default] [ivy:cachepath] found org.codehaus.groovy#groovy-all;2.4.15 in public [ivy:cachepath] :: resolution report :: resolve 14ms :: artifacts dl 1ms --------------------------------------------------------------------- | | modules || artifacts | | conf | number| search|dwnlded|evicted|| number|dwnlded| --------------------------------------------------------------------- | default | 1 | 0 | 0 | 0 || 1 | 0 | --------------------------------------------------------------------- -init-totals: -test: [mkdir] Created dir: /home/jenkins/workspace/Lucene-Solr-7.6-Linux/solr/build/solr-core/test [junit4:pickseed] Seed property 'tests.seed' already defined: 85A97E3967E2B3AD [mkdir] Created dir: /home/jenkins/workspace/Lucene-Solr-7.6-Linux/solr/build/solr-core/test/temp [junit4] <JUnit4> says שלום! Master seed: 85A97E3967E2B3AD [junit4] Executing 5 suites with 3 JVMs. [junit4] [junit4] Started J0 PID(19...@serv1.sd-datasolutions.de). [junit4] Started J2 PID(19...@serv1.sd-datasolutions.de). [junit4] Started J1 PID(19...@serv1.sd-datasolutions.de). [junit4] Suite: org.apache.solr.handler.component.DistributedDebugComponentTest [junit4] OK 0.21s J0 | DistributedDebugComponentTest.testCompareWithNonDistributedRequest [junit4] OK 0.27s J0 | DistributedDebugComponentTest.testDebugSections [junit4] OK 0.05s J0 | DistributedDebugComponentTest.testSimpleSearch [junit4] OK 2.00s J0 | DistributedDebugComponentTest.testRandom [junit4] OK 0.04s J0 | DistributedDebugComponentTest.testTolerantSearch [junit4] Completed [1/5] on J0 in 9.14s, 5 tests [junit4] [junit4] Suite: org.apache.solr.handler.component.DistributedDebugComponentTest [junit4] OK 0.26s J2 | DistributedDebugComponentTest.testCompareWithNonDistributedRequest [junit4] OK 0.30s J2 | DistributedDebugComponentTest.testDebugSections [junit4] OK 0.07s J2 | DistributedDebugComponentTest.testSimpleSearch [junit4] OK 1.88s J2 | DistributedDebugComponentTest.testRandom [junit4] OK 0.04s J2 | DistributedDebugComponentTest.testTolerantSearch [junit4] Completed [2/5] on J2 in 9.29s, 5 tests [junit4] [junit4] Suite: org.apache.solr.handler.component.DistributedDebugComponentTest [junit4] OK 0.26s J1 | DistributedDebugComponentTest.testCompareWithNonDistributedRequest [junit4] OK 0.32s J1 | DistributedDebugComponentTest.testDebugSections [junit4] OK 0.06s J1 | DistributedDebugComponentTest.testSimpleSearch [junit4] OK 2.08s J1 | DistributedDebugComponentTest.testRandom [junit4] OK 0.04s J1 | DistributedDebugComponentTest.testTolerantSearch [junit4] Completed [3/5] on J1 in 9.43s, 5 tests [junit4] [junit4] Duplicate suite name used with XML reports: org.apache.solr.handler.component.DistributedDebugComponentTest. This may confuse tools that process XML reports. Set 'ignoreDuplicateSuites' to true to skip this message. [junit4] Suite: org.apache.solr.handler.component.DistributedDebugComponentTest [junit4] OK 0.05s J0 | DistributedDebugComponentTest.testCompareWithNonDistributedRequest [junit4] OK 0.12s J0 | DistributedDebugComponentTest.testDebugSections [junit4] OK 0.03s J0 | DistributedDebugComponentTest.testSimpleSearch [junit4] OK 1.12s J0 | DistributedDebugComponentTest.testRandom [junit4] OK 0.02s J0 | DistributedDebugComponentTest.testTolerantSearch [junit4] Completed [4/5] on J0 in 3.47s, 5 tests [junit4] [junit4] Suite: org.apache.solr.handler.component.DistributedDebugComponentTest [junit4] OK 0.08s J2 | DistributedDebugComponentTest.testCompareWithNonDistributedRequest [junit4] OK 0.13s J2 | DistributedDebugComponentTest.testDebugSections [junit4] OK 0.03s J2 | DistributedDebugComponentTest.testSimpleSearch [junit4] OK 1.13s J2 | DistributedDebugComponentTest.testRandom [junit4] OK 0.02s J2 | DistributedDebugComponentTest.testTolerantSearch [junit4] Completed [5/5] on J2 in 3.45s, 5 tests [junit4] [junit4] JVM J0: 0.73 .. 13.78 = 13.06s [junit4] JVM J1: 0.77 .. 10.64 = 9.87s [junit4] JVM J2: 0.77 .. 14.16 = 13.40s [junit4] Execution time total: 14 seconds [junit4] Tests summary: 5 suites, 25 tests [junit4] Could not remove temporary path: /home/jenkins/workspace/Lucene-Solr-7.6-Linux/solr/build/solr-core/test/J1 (java.nio.file.DirectoryNotEmptyException: Remaining files: [/home/jenkins/workspace/Lucene-Solr-7.6-Linux/solr/build/solr-core/test/J1/temp]) [junit4] Could not remove temporary path: /home/jenkins/workspace/Lucene-Solr-7.6-Linux/solr/build/solr-core/test/J2 (java.nio.file.DirectoryNotEmptyException: Remaining files: [/home/jenkins/workspace/Lucene-Solr-7.6-Linux/solr/build/solr-core/test/J2/temp]) [junit4] Could not remove temporary path: /home/jenkins/workspace/Lucene-Solr-7.6-Linux/solr/build/solr-core/test/J0 (java.nio.file.DirectoryNotEmptyException: Remaining files: [/home/jenkins/workspace/Lucene-Solr-7.6-Linux/solr/build/solr-core/test/J0/temp]) [echo] 5 slowest tests: [junit4:tophints] 519.57s | org.apache.solr.cloud.cdcr.CdcrOpsAndBoundariesTest [junit4:tophints] 290.64s | org.apache.solr.cloud.cdcr.CdcrWithNodesRestartsTest [junit4:tophints] 213.19s | org.apache.solr.update.TestInPlaceUpdatesDistrib [junit4:tophints] 116.43s | org.apache.solr.update.SoftAutoCommitTest [junit4:tophints] 109.97s | org.apache.solr.cloud.ZkFailoverTest -check-totals: WARNING: An illegal reflective access operation has occurred WARNING: Illegal reflective access by org.codehaus.groovy.reflection.CachedClass (file:/home/jenkins/.ivy2/cache/org.codehaus.groovy/groovy-all/jars/groovy-all-2.4.15.jar) to method java.lang.Object.finalize() WARNING: Please consider reporting this to the maintainers of org.codehaus.groovy.reflection.CachedClass WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations WARNING: All illegal access operations will be denied in a future release test-nocompile: BUILD SUCCESSFUL Total time: 16 seconds [repro] Failures: [repro] 0/5 failed: org.apache.solr.handler.component.DistributedDebugComponentTest [repro] 3/5 failed: org.apache.solr.client.solrj.request.TestV2Request [repro] Exiting with code 256 + mv lucene/build lucene/build.repro + mv solr/build solr/build.repro + mv lucene/build.orig lucene/build + mv solr/build.orig solr/build Archiving artifacts Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 [WARNINGS] Parsing warnings in console log with parser Java Compiler (javac) Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 <Git Blamer> Using GitBlamer to create author and commit information for all warnings. <Git Blamer> GIT_COMMIT=719cde97f84640faa1e3525690d262946571245f, workspace=/var/lib/jenkins/workspace/Lucene-Solr-7.6-Linux [WARNINGS] Computing warning deltas based on reference build #74 Recording test results Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Build step 'Publish JUnit test result report' changed build result to UNSTABLE Email was triggered for: Unstable (Test Failures) Sending email for trigger: Unstable (Test Failures) Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org