You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2021/11/01 10:37:55 UTC
[JENKINS] Lucene » Lucene-Solr-Tests-8.x - Build # 3450 - Still Failing!
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.x/3450/
1 tests failed.
FAILED: org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest.test
Error Message:
Error from server at https://127.0.0.1:37245/collection1: org.apache.solr.client.solrj.SolrServerException: Time allowed to handle this request exceeded:[https://[::1]:4, https://[::1]:8]
Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:37245/collection1: org.apache.solr.client.solrj.SolrServerException: Time allowed to handle this request exceeded:[https://[::1]:4, https://[::1]:8]
at __randomizedtesting.SeedInfo.seed([644E748F1F5C6FF5:EC1A4B55B1A0020D]:0)
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:681)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:266)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:214)
at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1003)
at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1018)
at org.apache.solr.BaseDistributedSearchTestCase.queryServer(BaseDistributedSearchTestCase.java:623)
at org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest.queryAllowPartialResults(DistributedQueryComponentCustomSortTest.java:139)
at org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest.test(DistributedQueryComponentCustomSortTest.java:129)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1084)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1055)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
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:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 14676 lines...]
[junit4] Suite: org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest
[junit4] 2> 943830 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/server/solr/configsets/_default/conf'
[junit4] 2> 943830 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 943831 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.u.ErrorLogMuter Closing ErrorLogMuter-regex-188 after mutting 0 log messages
[junit4] 2> 943831 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.u.ErrorLogMuter Creating ErrorLogMuter-regex-189 for ERROR logs matching regex: ignore_exception
[junit4] 2> 943832 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_644E748F1F5C6FF5-001/data-dir-80-001
[junit4] 2> 943832 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2144 numCloses=2144
[junit4] 2> 943832 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 943834 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 943834 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 2> 943835 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 943840 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 943861 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
[junit4] 2> 943862 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
[junit4] 2> 943862 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead
[junit4] 2> 943863 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort
[junit4] 2> 943863 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 with uniqueid field id
[junit4] 2> 944405 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.c.CoreContainer Unable to create [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/userfiles]. Features requiring this directory may fail.
[junit4] 2> => java.security.AccessControlException: access denied ("java.io.FilePermission" "/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/userfiles" "write")
[junit4] 2> at java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
[junit4] 2> java.security.AccessControlException: access denied ("java.io.FilePermission" "/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/userfiles" "write")
[junit4] 2> at java.security.AccessControlContext.checkPermission(AccessControlContext.java:472) ~[?:1.8.0_291]
[junit4] 2> at java.security.AccessController.checkPermission(AccessController.java:886) ~[?:1.8.0_291]
[junit4] 2> at java.lang.SecurityManager.checkPermission(SecurityManager.java:549) ~[?:1.8.0_291]
[junit4] 2> at java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_291]
[junit4] 2> at sun.nio.fs.UnixPath.checkWrite(UnixPath.java:801) ~[?:?]
[junit4] 2> at sun.nio.fs.UnixFileSystemProvider.createDirectory(UnixFileSystemProvider.java:376) ~[?:?]
[junit4] 2> at java.nio.file.Files.createDirectory(Files.java:674) ~[?:1.8.0_291]
[junit4] 2> at java.nio.file.Files.createAndCheckIsDirectory(Files.java:781) ~[?:1.8.0_291]
[junit4] 2> at java.nio.file.Files.createDirectories(Files.java:727) ~[?:1.8.0_291]
[junit4] 2> at org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:378) [java/:?]
[junit4] 2> at org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:343) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:183) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:156) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:162) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:830) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:820) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:667) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:656) [java/:?]
[junit4] 2> at org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest.setUpBeforeClass(DistributedQueryComponentCustomSortTest.java:44) [test/:?]
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_291]
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_291]
[junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_291]
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_291]
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:878) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at org.junit.rules.RunRules.evaluate(RunRules.java:20) [junit-4.13.1.jar:4.13.1]
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [java/:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) [java/:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) [java/:?]
[junit4] 2> at org.junit.rules.RunRules.evaluate(RunRules.java:20) [junit-4.13.1.jar:4.13.1]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at java.lang.Thread.run(Thread.java:748) [?:1.8.0_291]
[junit4] 2> 944406 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.f.DistribPackageStore Unable to create [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/filestore] directory in SOLR_HOME [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr]. Features requiring this directory may fail.
[junit4] 2> => java.security.AccessControlException: access denied ("java.io.FilePermission" "/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/filestore" "write")
[junit4] 2> at java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
[junit4] 2> java.security.AccessControlException: access denied ("java.io.FilePermission" "/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/filestore" "write")
[junit4] 2> at java.security.AccessControlContext.checkPermission(AccessControlContext.java:472) ~[?:1.8.0_291]
[junit4] 2> at java.security.AccessController.checkPermission(AccessController.java:886) ~[?:1.8.0_291]
[junit4] 2> at java.lang.SecurityManager.checkPermission(SecurityManager.java:549) ~[?:1.8.0_291]
[junit4] 2> at java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_291]
[junit4] 2> at java.io.File.mkdir(File.java:1348) ~[?:1.8.0_291]
[junit4] 2> at java.io.File.mkdirs(File.java:1380) ~[?:1.8.0_291]
[junit4] 2> at org.apache.solr.filestore.DistribPackageStore.ensurePackageStoreDir(DistribPackageStore.java:561) [java/:?]
[junit4] 2> at org.apache.solr.filestore.DistribPackageStore.<init>(DistribPackageStore.java:81) [java/:?]
[junit4] 2> at org.apache.solr.filestore.PackageStoreAPI.<init>(PackageStoreAPI.java:78) [java/:?]
[junit4] 2> at org.apache.solr.core.CoreContainer.load(CoreContainer.java:679) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:184) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:156) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:162) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:830) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:820) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:667) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:656) [java/:?]
[junit4] 2> at org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest.setUpBeforeClass(DistributedQueryComponentCustomSortTest.java:44) [test/:?]
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_291]
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_291]
[junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_291]
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_291]
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:878) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at org.junit.rules.RunRules.evaluate(RunRules.java:20) [junit-4.13.1.jar:4.13.1]
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [java/:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) [java/:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) [java/:?]
[junit4] 2> at org.junit.rules.RunRules.evaluate(RunRules.java:20) [junit-4.13.1.jar:4.13.1]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at java.lang.Thread.run(Thread.java:748) [?:1.8.0_291]
[junit4] 2> 944407 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 944408 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 944408 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@39467021[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 944408 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@39467021[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 944411 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 944411 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@4316490b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 944411 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@4316490b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 944413 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 944439 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4f95b8c0
[junit4] 2> 944445 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4f95b8c0
[junit4] 2> 944445 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4f95b8c0
[junit4] 2> 944446 INFO (coreLoadExecutor-8801-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 2147483647 cores with initial capacity of 1024
[junit4] 2> 944454 INFO (coreLoadExecutor-8801-thread-1) [ x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 944470 INFO (coreLoadExecutor-8801-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
[junit4] 2> 944470 WARN (coreLoadExecutor-8801-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
[junit4] 2> 944471 WARN (coreLoadExecutor-8801-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead
[junit4] 2> 944472 INFO (coreLoadExecutor-8801-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort
[junit4] 2> 944472 INFO (coreLoadExecutor-8801-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 with uniqueid field id
[junit4] 2> 944472 INFO (coreLoadExecutor-8801-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 944473 INFO (coreLoadExecutor-8801-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@4f95b8c0
[junit4] 2> 944473 INFO (coreLoadExecutor-8801-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_644E748F1F5C6FF5-001/data-dir-80-001/]
[junit4] 2> 944474 INFO (coreLoadExecutor-8801-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=10, maxMergeAtOnceExplicit=20, maxMergedSegmentMB=49.9775390625, floorSegmentMB=1.7119140625, forceMergeDeletesPctAllowed=16.33142190974937, segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, deletesPctAllowed=31.311980750419522
[junit4] 2> 944523 INFO (coreLoadExecutor-8801-thread-1) [ x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 944523 INFO (coreLoadExecutor-8801-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 944524 INFO (coreLoadExecutor-8801-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 944524 INFO (coreLoadExecutor-8801-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 944525 INFO (coreLoadExecutor-8801-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=43, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 944525 INFO (coreLoadExecutor-8801-thread-1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 944536 INFO (coreLoadExecutor-8801-thread-1) [ x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 944585 INFO (coreLoadExecutor-8801-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 944585 INFO (coreLoadExecutor-8801-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1715218991622914048
[junit4] 2> 944586 INFO (searcherExecutor-8803-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 944587 INFO (searcherExecutor-8803-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 944587 INFO (searcherExecutor-8803-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 944587 INFO (searcherExecutor-8803-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 944587 INFO (searcherExecutor-8803-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 944587 INFO (searcherExecutor-8803-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 944587 INFO (searcherExecutor-8803-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 944588 INFO (searcherExecutor-8803-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 944588 INFO (searcherExecutor-8803-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 944588 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 944589 INFO (searcherExecutor-8803-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 944594 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.u.ErrorLogMuter Closing ErrorLogMuter-regex-189 after mutting 0 log messages
[junit4] 2> 944594 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.u.ErrorLogMuter Creating ErrorLogMuter-regex-190 for ERROR logs matching regex: ignore_exception
[junit4] 2> 944694 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_644E748F1F5C6FF5-001/tempDir-001/control/cores/collection1
[junit4] 2> 944696 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 944696 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 944696 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.s.Server jetty-9.4.44.v20210927; built: 2021-09-27T23:02:44.612Z; git: 8da83308eeca865e495e53ef315a249d63ba9332; jvm 1.8.0_291-b10
[junit4] 2> 944696 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 944696 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 944696 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 944697 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@d96bebb{/,null,AVAILABLE}
[junit4] 2> 944697 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@71acb6a6{SSL, (ssl, http/1.1)}{127.0.0.1:42609}
[junit4] 2> 944697 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.s.Server Started @944728ms
[junit4] 2> 944697 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema-custom-field.xml, solrconfig=solrconfig.xml, hostContext=/, hostPort=42609, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_644E748F1F5C6FF5-001/tempDir-001/control/cores}
[junit4] 2> 944698 ERROR (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 944698 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 944698 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.11.0
[junit4] 2> 944698 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 944698 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
[junit4] 2> 944698 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-11-01T09:51:39.436Z
[junit4] 2> 944698 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_644E748F1F5C6FF5-001/tempDir-001/control/solr.xml
[junit4] 2> 944700 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 944700 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 944701 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@4f95b8c0, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 945138 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 945139 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 945139 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@2a5ce082[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 945139 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@2a5ce082[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 945142 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 945143 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@20e5ebf1[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 945143 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@20e5ebf1[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 945144 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 945154 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4
[junit4] 2> 945154 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 945173 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4f95b8c0
[junit4] 2> 945181 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4f95b8c0
[junit4] 2> 945181 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4f95b8c0
[junit4] 2> 945183 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_644E748F1F5C6FF5-001/tempDir-001/control/cores
[junit4] 2> 945183 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 945214 INFO (coreLoadExecutor-8821-thread-1) [ x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 945230 INFO (coreLoadExecutor-8821-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
[junit4] 2> 945230 WARN (coreLoadExecutor-8821-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
[junit4] 2> 945230 WARN (coreLoadExecutor-8821-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead
[junit4] 2> 945232 INFO (coreLoadExecutor-8821-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort
[junit4] 2> 945232 INFO (coreLoadExecutor-8821-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 with uniqueid field id
[junit4] 2> 945232 INFO (coreLoadExecutor-8821-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 945232 INFO (coreLoadExecutor-8821-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@4f95b8c0
[junit4] 2> 945232 INFO (coreLoadExecutor-8821-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_644E748F1F5C6FF5-001/tempDir-001/control/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_644E748F1F5C6FF5-001/tempDir-001/control/cores/collection1/data/]
[junit4] 2> 945233 INFO (coreLoadExecutor-8821-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=10, maxMergeAtOnceExplicit=20, maxMergedSegmentMB=49.9775390625, floorSegmentMB=1.7119140625, forceMergeDeletesPctAllowed=16.33142190974937, segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, deletesPctAllowed=31.311980750419522
[junit4] 2> 945284 INFO (coreLoadExecutor-8821-thread-1) [ x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 945284 INFO (coreLoadExecutor-8821-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 945285 INFO (coreLoadExecutor-8821-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 945285 INFO (coreLoadExecutor-8821-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 945286 INFO (coreLoadExecutor-8821-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=43, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 945286 INFO (coreLoadExecutor-8821-thread-1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 945296 INFO (coreLoadExecutor-8821-thread-1) [ x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 945320 INFO (coreLoadExecutor-8821-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 945320 INFO (coreLoadExecutor-8821-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1715218992393617408
[junit4] 2> 945322 INFO (searcherExecutor-8823-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 945322 INFO (searcherExecutor-8823-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 945322 INFO (searcherExecutor-8823-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 945322 INFO (searcherExecutor-8823-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 945322 INFO (searcherExecutor-8823-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 945322 INFO (searcherExecutor-8823-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 945322 INFO (searcherExecutor-8823-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 945322 INFO (searcherExecutor-8823-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 945323 INFO (searcherExecutor-8823-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 945324 INFO (searcherExecutor-8823-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 945427 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_644E748F1F5C6FF5-001/tempDir-001/shard0/cores/collection1
[junit4] 2> 945428 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 945428 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 945428 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.s.Server jetty-9.4.44.v20210927; built: 2021-09-27T23:02:44.612Z; git: 8da83308eeca865e495e53ef315a249d63ba9332; jvm 1.8.0_291-b10
[junit4] 2> 945428 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 945428 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 945428 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 945429 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@26ccc453{/,null,AVAILABLE}
[junit4] 2> 945429 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@3f05abf4{SSL, (ssl, http/1.1)}{127.0.0.1:32953}
[junit4] 2> 945429 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.s.Server Started @945460ms
[junit4] 2> 945429 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema-custom-field.xml, solrconfig=solrconfig.xml, hostContext=/, hostPort=32953, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_644E748F1F5C6FF5-001/tempDir-001/shard0/cores}
[junit4] 2> 945430 ERROR (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 945430 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 945430 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.11.0
[junit4] 2> 945430 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 945430 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
[junit4] 2> 945430 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-11-01T09:51:40.168Z
[junit4] 2> 945430 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_644E748F1F5C6FF5-001/tempDir-001/shard0/solr.xml
[junit4] 2> 945432 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 945432 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 945433 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@4f95b8c0, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 946123 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 946123 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 946124 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@5cde79ea[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 946124 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@5cde79ea[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 946127 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 946132 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@57491b0d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 946132 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@57491b0d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 946134 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 946144 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4
[junit4] 2> 946144 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 946165 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4f95b8c0
[junit4] 2> 946176 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4f95b8c0
[junit4] 2> 946176 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4f95b8c0
[junit4] 2> 946178 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_644E748F1F5C6FF5-001/tempDir-001/shard0/cores
[junit4] 2> 946178 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 946185 INFO (coreLoadExecutor-8840-thread-1) [ x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 946211 INFO (coreLoadExecutor-8840-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
[junit4] 2> 946211 WARN (coreLoadExecutor-8840-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
[junit4] 2> 946211 WARN (coreLoadExecutor-8840-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead
[junit4] 2> 946212 INFO (coreLoadExecutor-8840-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort
[junit4] 2> 946213 INFO (coreLoadExecutor-8840-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 with uniqueid field id
[junit4] 2> 946213 INFO (coreLoadExecutor-8840-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 946213 INFO (coreLoadExecutor-8840-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@4f95b8c0
[junit4] 2> 946213 INFO (coreLoadExecutor-8840-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_644E748F1F5C6FF5-001/tempDir-001/shard0/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_644E748F1F5C6FF5-001/tempDir-001/shard0/cores/collection1/data/]
[junit4] 2> 946214 INFO (coreLoadExecutor-8840-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=10, maxMergeAtOnceExplicit=20, maxMergedSegmentMB=49.9775390625, floorSegmentMB=1.7119140625, forceMergeDeletesPctAllowed=16.33142190974937, segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, deletesPctAllowed=31.311980750419522
[junit4] 2> 946264 INFO (coreLoadExecutor-8840-thread-1) [ x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 946265 INFO (coreLoadExecutor-8840-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 946265 INFO (coreLoadExecutor-8840-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 946265 INFO (coreLoadExecutor-8840-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 946266 INFO (coreLoadExecutor-8840-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=43, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 946267 INFO (coreLoadExecutor-8840-thread-1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 946278 INFO (coreLoadExecutor-8840-thread-1) [ x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 946310 INFO (coreLoadExecutor-8840-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 946310 INFO (coreLoadExecutor-8840-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1715218993431707648
[junit4] 2> 946312 INFO (searcherExecutor-8842-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 946312 INFO (searcherExecutor-8842-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 946312 INFO (searcherExecutor-8842-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 946312 INFO (searcherExecutor-8842-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 946312 INFO (searcherExecutor-8842-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 946312 INFO (searcherExecutor-8842-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 946312 INFO (searcherExecutor-8842-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 946312 INFO (searcherExecutor-8842-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 946313 INFO (searcherExecutor-8842-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 946314 INFO (searcherExecutor-8842-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 946415 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_644E748F1F5C6FF5-001/tempDir-001/shard1/cores/collection1
[junit4] 2> 946416 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 946416 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 946416 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.s.Server jetty-9.4.44.v20210927; built: 2021-09-27T23:02:44.612Z; git: 8da83308eeca865e495e53ef315a249d63ba9332; jvm 1.8.0_291-b10
[junit4] 2> 946417 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 946417 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 946417 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 946417 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2e0593d{/,null,AVAILABLE}
[junit4] 2> 946418 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@14fe745{SSL, (ssl, http/1.1)}{127.0.0.1:46131}
[junit4] 2> 946418 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.s.Server Started @946448ms
[junit4] 2> 946418 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema-custom-field.xml, solrconfig=solrconfig.xml, hostContext=/, hostPort=46131, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_644E748F1F5C6FF5-001/tempDir-001/shard1/cores}
[junit4] 2> 946418 ERROR (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 946418 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 946418 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.11.0
[junit4] 2> 946418 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 946418 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
[junit4] 2> 946418 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-11-01T09:51:41.156Z
[junit4] 2> 946418 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_644E748F1F5C6FF5-001/tempDir-001/shard1/solr.xml
[junit4] 2> 946421 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 946421 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 946422 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@4f95b8c0, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 948486 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 948487 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 948488 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@1342c6b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 948488 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@1342c6b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 948490 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 948491 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@a20c7de[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 948491 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@a20c7de[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 948492 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 948503 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4
[junit4] 2> 948503 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 948522 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4f95b8c0
[junit4] 2> 948533 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4f95b8c0
[junit4] 2> 948533 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4f95b8c0
[junit4] 2> 948534 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_644E748F1F5C6FF5-001/tempDir-001/shard1/cores
[junit4] 2> 948534 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 948542 INFO (coreLoadExecutor-8859-thread-1) [ x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 948571 INFO (coreLoadExecutor-8859-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
[junit4] 2> 948571 WARN (coreLoadExecutor-8859-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
[junit4] 2> 948571 WARN (coreLoadExecutor-8859-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead
[junit4] 2> 948572 INFO (coreLoadExecutor-8859-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort
[junit4] 2> 948573 INFO (coreLoadExecutor-8859-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 with uniqueid field id
[junit4] 2> 948573 INFO (coreLoadExecutor-8859-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 948573 INFO (coreLoadExecutor-8859-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@4f95b8c0
[junit4] 2> 948573 INFO (coreLoadExecutor-8859-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_644E748F1F5C6FF5-001/tempDir-001/shard1/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_644E748F1F5C6FF5-001/tempDir-001/shard1/cores/collection1/data/]
[junit4] 2> 948574 INFO (coreLoadExecutor-8859-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=10, maxMergeAtOnceExplicit=20, maxMergedSegmentMB=49.9775390625, floorSegmentMB=1.7119140625, forceMergeDeletesPctAllowed=16.33142190974937, segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, deletesPctAllowed=31.311980750419522
[junit4] 2> 948624 INFO (coreLoadExecutor-8859-thread-1) [ x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 948624 INFO (coreLoadExecutor-8859-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 948625 INFO (coreLoadExecutor-8859-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 948625 INFO (coreLoadExecutor-8859-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 948626 INFO (coreLoadExecutor-8859-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=43, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 948627 INFO (coreLoadExecutor-8859-thread-1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 948633 INFO (coreLoadExecutor-8859-thread-1) [ x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 948654 INFO (coreLoadExecutor-8859-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 948654 INFO (coreLoadExecutor-8859-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1715218995889569792
[junit4] 2> 948655 INFO (searcherExecutor-8861-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 948656 INFO (searcherExecutor-8861-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 948656 INFO (searcherExecutor-8861-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 948656 INFO (searcherExecutor-8861-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 948656 INFO (searcherExecutor-8861-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 948656 INFO (searcherExecutor-8861-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 948656 INFO (searcherExecutor-8861-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 948656 INFO (searcherExecutor-8861-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 948656 INFO (searcherExecutor-8861-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 948659 INFO (searcherExecutor-8861-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 948760 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_644E748F1F5C6FF5-001/tempDir-001/shard2/cores/collection1
[junit4] 2> 948761 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 948761 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 948761 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.s.Server jetty-9.4.44.v20210927; built: 2021-09-27T23:02:44.612Z; git: 8da83308eeca865e495e53ef315a249d63ba9332; jvm 1.8.0_291-b10
[junit4] 2> 948762 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 948762 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 948762 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 948763 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@22634c72{/,null,AVAILABLE}
[junit4] 2> 948763 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@45d601fd{SSL, (ssl, http/1.1)}{127.0.0.1:37245}
[junit4] 2> 948763 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.s.Server Started @948794ms
[junit4] 2> 948763 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema-custom-field.xml, solrconfig=solrconfig.xml, hostContext=/, hostPort=37245, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_644E748F1F5C6FF5-001/tempDir-001/shard2/cores}
[junit4] 2> 948764 ERROR (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 948764 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 948764 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.11.0
[junit4] 2> 948764 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 948764 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
[junit4] 2> 948764 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-11-01T09:51:43.502Z
[junit4] 2> 948764 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_644E748F1F5C6FF5-001/tempDir-001/shard2/solr.xml
[junit4] 2> 948766 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 948766 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 948767 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@4f95b8c0, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 949390 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 949390 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 949391 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@4ddc621d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 949391 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@4ddc621d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 949394 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 949395 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@150f944e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 949395 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@150f944e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 949396 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 949407 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4
[junit4] 2> 949407 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 949427 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4f95b8c0
[junit4] 2> 949438 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4f95b8c0
[junit4] 2> 949438 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4f95b8c0
[junit4] 2> 949439 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_644E748F1F5C6FF5-001/tempDir-001/shard2/cores
[junit4] 2> 949439 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[644E748F1F5C6FF5]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 949447 INFO (coreLoadExecutor-8878-thread-1) [ x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 949473 INFO (coreLoadExecutor-8878-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
[junit4] 2> 949473 WARN (coreLoadExecutor-8878-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
[junit4] 2> 949474 WARN (coreLoadExecutor-8878-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead
[junit4] 2> 949475 INFO (coreLoadExecutor-8878-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort
[junit4] 2> 949475 INFO (coreLoadExecutor-8878-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 with uniqueid field id
[junit4] 2> 949475 INFO (coreLoadExecutor-8878-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 949475 INFO (coreLoadExecutor-8878-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@4f95b8c0
[junit4] 2> 949476 INFO (coreLoadExecutor-8878-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_644E748F1F5C6FF5-001/tempDir-001/shard2/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_644E748F1F5C6FF5-001/tempDir-001/shard2/cores/collection1/data/]
[junit4] 2> 949477 INFO (coreLoadExecutor-8878-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.
[...truncated too long message...]
vice url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@414bd858
[junit4] 2> 950193 INFO (closeThreadPool-8888-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 950193 INFO (closeThreadPool-8888-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@65bf9cf8: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@14037c5a
[junit4] 2> 950196 INFO (closeThreadPool-8888-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@45d601fd{SSL, (ssl, http/1.1)}{127.0.0.1:0}
[junit4] 2> 950196 INFO (closeThreadPool-8888-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@22634c72{/,null,STOPPED}
[junit4] 2> 950196 INFO (closeThreadPool-8888-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=DistributedQueryComponentCustomSortTest -Dtests.method=test -Dtests.seed=644E748F1F5C6FF5 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=en-US -Dtests.timezone=Atlantic/Stanley -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] ERROR 5.61s J1 | DistributedQueryComponentCustomSortTest.test <<<
[junit4] > Throwable #1: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:37245/collection1: org.apache.solr.client.solrj.SolrServerException: Time allowed to handle this request exceeded:[https://[::1]:4, https://[::1]:8]
[junit4] > at __randomizedtesting.SeedInfo.seed([644E748F1F5C6FF5:EC1A4B55B1A0020D]:0)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:681)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:266)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
[junit4] > at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:214)
[junit4] > at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1003)
[junit4] > at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1018)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase.queryServer(BaseDistributedSearchTestCase.java:623)
[junit4] > at org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest.queryAllowPartialResults(DistributedQueryComponentCustomSortTest.java:139)
[junit4] > at org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest.test(DistributedQueryComponentCustomSortTest.java:129)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1084)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1055)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 950198 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 950199 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=479659369
[junit4] 2> 950199 INFO (coreCloseExecutor-8906-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@4ee6c7b2
[junit4] 2> 950199 INFO (coreCloseExecutor-8906-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1 tag=SolrCore@4ee6c7b2
[junit4] 2> 950199 INFO (coreCloseExecutor-8906-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@e40f9b1: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1/com.codahale.metrics.MetricRegistry@56b9deac
[junit4] 2> 950202 INFO (coreCloseExecutor-8906-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED (unnecessary).
[junit4] 2> 950203 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
[junit4] 2> 950203 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@64e0a697: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@9983c77
[junit4] 2> 950204 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
[junit4] 2> 950204 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4db83347: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@414bd858
[junit4] 2> 950204 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 950204 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@439e0a91: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@14037c5a
[junit4] 2> 950206 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.u.ErrorLogMuter Closing ErrorLogMuter-regex-190 after mutting 0 log messages
[junit4] 2> 950206 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[644E748F1F5C6FF5]-worker) [ ] o.a.s.u.ErrorLogMuter Creating ErrorLogMuter-regex-191 for ERROR logs matching regex: ignore_exception
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_644E748F1F5C6FF5-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene87), sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=en-US, timezone=Atlantic/Stanley
[junit4] 2> NOTE: Linux 5.4.0-45-generic amd64/Oracle Corporation 1.8.0_291 (64-bit)/cpus=4,threads=1,free=49366752,total=526909440
[junit4] 2> NOTE: All tests run in this JVM: [ClusterStateTest, ResponseHeaderTest, EmbeddedSolrNoSerializeTest, DocumentBuilderTest, MetricsHistoryHandlerTest, TestDistributedSearch, TestContainerPlugin, TestValueSourceCache, BasicFunctionalityTest, SystemInfoHandlerTest, WordBreakSolrSpellCheckerTest, SearchRateTriggerIntegrationTest, TestPullReplicaErrorHandling, ResponseBuilderTest, ScriptEngineTest, SpellCheckCollatorWithCollapseTest, BinaryUpdateRequestHandlerTest, TestLogWatcher, JsonLoaderTest, TestBulkSchemaAPI, AtomicUpdateProcessorFactoryTest, TestInPlaceUpdateWithRouteField, LocalFSCloudIncrementalBackupTest, TestCrossCoreJoin, TestLFUCache, TestJavabinTupleStreamParser, SyncSliceTest, SolrCoreMetricManagerTest, QueryParsingTest, TestSolrConfigHandlerCloud, CoreAdminHandlerTest, SuggesterWFSTTest, ZookeeperStatusHandlerFailureTest, DistributedIntervalFacetingTest, RankFieldTest, SolrCLIZkUtilsTest, ReindexCollectionTest, TestUnifiedSolrHighlighter, HighlighterMaxOffsetTest, SolrIndexSplitterTest, TestCSVResponseWriter, BJQFilterAccessibleTest, SolrLogPostToolTest, TestExactSharedStatsCache, HdfsNNFailoverTest, ReplicationFactorTest, ManagedSchemaRoundRobinCloudTest, TestBM25SimilarityFactory, IgnoreCommitOptimizeUpdateProcessorFactoryTest, OverseerSolrResponseUnsafeSerializationTest, ConnectionReuseTest, CoreSorterTest, HdfsSyncSliceTest, SplitByPrefixTest, TestAddFieldRealTimeGet, MetricsHistoryWithAuthIntegrationTest, TestSolrJ, TestConfLoadPerf, TestConfigSetsAPIZkFailure, TestEmbeddedSolrServerAdminHandler, MoveReplicaHDFSTest, UpdateLogTest, ChaosMonkeyNothingIsSafeTest, TestCloudNestedDocsSort, TestNRTOpen, UUIDUpdateProcessorFallbackTest, TestPackages, TestTolerantUpdateProcessorCloud, HdfsDirectoryFactoryTest, TestRandomRequestDistribution, TestSimNodeAddedTrigger, AssignBackwardCompatibilityTest, TestShardHandlerFactory, JWTAuthPluginIntegrationTest, TestHashPartitioner, TestSchemaDesignerSettingsDAO, TestPhraseSuggestions, TestJmxIntegration, SpellCheckComponentTest, TestSimExecutePlanAction, TestMacros, TestStressInPlaceUpdates, DistributedQueryComponentCustomSortTest]
[junit4] Completed [391/950 (1!)] on J1 in 6.51s, 1 test, 1 error <<< FAILURES!
[...truncated 56091 lines...]
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:619: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:492: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:479: Source checkout is dirty (unversioned/missing files) after running tests!!! Offending files:
* solr/licenses/annotations-2.17.63.jar.sha1
Total time: 74 minutes 29 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
[Checks API] No suitable checks publisher found.
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
[JENKINS] Lucene » Lucene-Solr-Tests-8.x - Build # 3457 - Still Failing!
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.x/3457/
1 tests failed.
FAILED: org.apache.solr.metrics.reporters.solr.SolrCloudReportersTest.testExplicitConfiguration
Error Message:
leader.test_collection.shard1.UPDATE./update.requests.max
Stack Trace:
java.lang.AssertionError: leader.test_collection.shard1.UPDATE./update.requests.max
at __randomizedtesting.SeedInfo.seed([347ADE21146CEAD6:70B6FEDA7A563CBC]:0)
at org.junit.Assert.fail(Assert.java:89)
at org.junit.Assert.assertTrue(Assert.java:42)
at org.apache.solr.metrics.reporters.solr.SolrCloudReportersTest.lambda$testExplicitConfiguration$1(SolrCloudReportersTest.java:156)
at java.util.concurrent.CopyOnWriteArrayList.forEach(CopyOnWriteArrayList.java:895)
at java.util.Collections$UnmodifiableCollection.forEach(Collections.java:1082)
at org.apache.solr.metrics.reporters.solr.SolrCloudReportersTest.testExplicitConfiguration(SolrCloudReportersTest.java:81)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
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:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 15885 lines...]
[junit4] Suite: org.apache.solr.metrics.reporters.solr.SolrCloudReportersTest
[junit4] 2> 2107206 INFO (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/server/solr/configsets/_default/conf'
[junit4] 2> 2107207 INFO (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker) [ ] o.a.s.u.ErrorLogMuter Closing ErrorLogMuter-regex-503 after mutting 0 log messages
[junit4] 2> 2107207 INFO (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker) [ ] o.a.s.u.ErrorLogMuter Creating ErrorLogMuter-regex-504 for ERROR logs matching regex: ignore_exception
[junit4] 2> 2107207 INFO (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.metrics.reporters.solr.SolrCloudReportersTest_347ADE21146CEAD6-001/data-dir-181-001
[junit4] 2> 2107207 WARN (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
[junit4] 2> 2107208 INFO (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 2107210 INFO (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 2107210 INFO (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 2107210 INFO (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker) [ ] o.a.s.c.SolrCloudTestCase Using per-replica state
[junit4] 2> 2107210 INFO (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 0 servers in /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.metrics.reporters.solr.SolrCloudReportersTest_347ADE21146CEAD6-001/tempDir-001
[junit4] 2> 2107210 INFO (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2107211 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 2107211 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 2107212 WARN (ZkTestServer Run Thread) [ ] o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
[junit4] 2> 2107311 INFO (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port: 46349
[junit4] 2> 2107311 INFO (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:46349
[junit4] 2> 2107311 INFO (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:46349
[junit4] 2> 2107311 INFO (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 46349
[junit4] 2> 2107314 INFO (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2107318 INFO (zkConnectionManagerCallback-18955-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2107318 INFO (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2107325 INFO (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2107327 INFO (zkConnectionManagerCallback-18957-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2107327 INFO (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2107328 INFO (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2107332 INFO (zkConnectionManagerCallback-18959-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2107332 INFO (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2107445 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testDefaultPlugins
[junit4] 2> 2107445 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 2107445 WARN (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker-SendThread(127.0.0.1:46349)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10897bc695d0000.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10897bc695d0000, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x10897bc695d0000, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 2107546 WARN (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker-SendThread(127.0.0.1:46349)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10897bc695d0001.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10897bc695d0001, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x10897bc695d0001, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 2107649 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:46349
[junit4] 2> 2107649 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:46349
[junit4] 2> 2107649 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 46349
[junit4] 2> 2107649 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.metrics.reporters.solr.SolrCloudReportersTest_347ADE21146CEAD6-001/tempDir-002
[junit4] 2> 2107650 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2107650 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 2107650 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 2107651 WARN (ZkTestServer Run Thread) [ ] o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
[junit4] 2> 2107750 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.ZkTestServer start zk server on port: 32909
[junit4] 2> 2107750 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:32909
[junit4] 2> 2107750 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:32909
[junit4] 2> 2107750 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 32909
[junit4] 2> 2107761 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2107762 INFO (zkConnectionManagerCallback-18964-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2107762 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2107771 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2107772 INFO (zkConnectionManagerCallback-18966-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2107772 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2107773 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2107774 INFO (zkConnectionManagerCallback-18968-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2107774 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2107778 WARN (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]-SendThread(127.0.0.1:32909)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10897bc6b1b0002.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10897bc6b1b0002, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x10897bc6b1b0002, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 2107879 INFO (jetty-launcher-18969-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 2107879 INFO (jetty-launcher-18969-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 2107880 INFO (jetty-launcher-18969-thread-1) [ ] o.e.j.s.Server jetty-9.4.44.v20210927; built: 2021-09-27T23:02:44.612Z; git: 8da83308eeca865e495e53ef315a249d63ba9332; jvm 1.8.0_291-b10
[junit4] 2> 2107880 INFO (jetty-launcher-18969-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 2107880 INFO (jetty-launcher-18969-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 2107880 INFO (jetty-launcher-18969-thread-2) [ ] o.e.j.s.Server jetty-9.4.44.v20210927; built: 2021-09-27T23:02:44.612Z; git: 8da83308eeca865e495e53ef315a249d63ba9332; jvm 1.8.0_291-b10
[junit4] 2> 2107882 INFO (jetty-launcher-18969-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2107882 INFO (jetty-launcher-18969-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2107883 INFO (jetty-launcher-18969-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2107883 INFO (jetty-launcher-18969-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@15544bc8{/solr,null,AVAILABLE}
[junit4] 2> 2107884 INFO (jetty-launcher-18969-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5aee0def{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42547}
[junit4] 2> 2107884 INFO (jetty-launcher-18969-thread-1) [ ] o.e.j.s.Server Started @2107915ms
[junit4] 2> 2107884 INFO (jetty-launcher-18969-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, zkHost=127.0.0.1:32909/solr, hostPort=42547}
[junit4] 2> 2107884 ERROR (jetty-launcher-18969-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2107884 INFO (jetty-launcher-18969-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2107884 INFO (jetty-launcher-18969-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.11.0
[junit4] 2> 2107884 INFO (jetty-launcher-18969-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2107884 INFO (jetty-launcher-18969-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
[junit4] 2> 2107884 INFO (jetty-launcher-18969-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-11-02T13:20:52.936Z
[junit4] 2> 2107884 INFO (jetty-launcher-18969-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2107885 INFO (jetty-launcher-18969-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2107885 INFO (jetty-launcher-18969-thread-2) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2107886 INFO (jetty-launcher-18969-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2107890 INFO (jetty-launcher-18969-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6c11d3dc{/solr,null,AVAILABLE}
[junit4] 2> 2107890 INFO (jetty-launcher-18969-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@10936a41{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:36277}
[junit4] 2> 2107890 INFO (jetty-launcher-18969-thread-2) [ ] o.e.j.s.Server Started @2107921ms
[junit4] 2> 2107890 INFO (jetty-launcher-18969-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, zkHost=127.0.0.1:32909/solr, hostPort=36277}
[junit4] 2> 2107890 ERROR (jetty-launcher-18969-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2107890 INFO (jetty-launcher-18969-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2107890 INFO (jetty-launcher-18969-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.11.0
[junit4] 2> 2107890 INFO (jetty-launcher-18969-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2107890 INFO (jetty-launcher-18969-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
[junit4] 2> 2107890 INFO (jetty-launcher-18969-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-11-02T13:20:52.942Z
[junit4] 2> 2107891 INFO (jetty-launcher-18969-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2107892 INFO (zkConnectionManagerCallback-18971-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2107892 INFO (jetty-launcher-18969-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2107892 INFO (zkConnectionManagerCallback-18973-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2107892 INFO (jetty-launcher-18969-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2107892 INFO (jetty-launcher-18969-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2107892 INFO (jetty-launcher-18969-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2107895 INFO (jetty-launcher-18969-thread-1) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 2107895 INFO (jetty-launcher-18969-thread-1) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 2107895 INFO (jetty-launcher-18969-thread-2) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 2107895 INFO (jetty-launcher-18969-thread-2) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 2107896 INFO (jetty-launcher-18969-thread-2) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@4a09e561, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 2107904 INFO (jetty-launcher-18969-thread-1) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@4a09e561, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 2107905 WARN (jetty-launcher-18969-thread-1-SendThread(127.0.0.1:32909)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10897bc6b1b0003.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10897bc6b1b0003, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x10897bc6b1b0003, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 2108126 INFO (jetty-launcher-18969-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 2108134 WARN (jetty-launcher-18969-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@4b6070d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2108134 WARN (jetty-launcher-18969-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@4b6070d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2108138 WARN (jetty-launcher-18969-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@7478c76f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2108138 WARN (jetty-launcher-18969-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@7478c76f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2108140 INFO (jetty-launcher-18969-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:32909/solr
[junit4] 2> 2108141 INFO (jetty-launcher-18969-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2108145 INFO (zkConnectionManagerCallback-18987-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2108145 INFO (jetty-launcher-18969-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2108254 INFO (jetty-launcher-18969-thread-1) [n:127.0.0.1:42547_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2108258 INFO (zkConnectionManagerCallback-18989-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2108258 INFO (jetty-launcher-18969-thread-1) [n:127.0.0.1:42547_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2108323 WARN (jetty-launcher-18969-thread-1) [n:127.0.0.1:42547_solr ] o.a.s.c.ZkController Contents of zookeeper /security.json are world-readable; consider setting up ACLs as described in https://solr.apache.org/guide/zookeeper-access-control.html
[junit4] 2> 2108326 INFO (jetty-launcher-18969-thread-1) [n:127.0.0.1:42547_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:42547_solr
[junit4] 2> 2108327 INFO (jetty-launcher-18969-thread-1) [n:127.0.0.1:42547_solr ] o.a.s.c.Overseer Overseer (id=74476229358190598-127.0.0.1:42547_solr-n_0000000000) starting
[junit4] 2> 2108331 INFO (OverseerStateUpdate-74476229358190598-127.0.0.1:42547_solr-n_0000000000) [n:127.0.0.1:42547_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:42547_solr
[junit4] 2> 2108338 INFO (jetty-launcher-18969-thread-1) [n:127.0.0.1:42547_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:42547_solr
[junit4] 2> 2108340 INFO (jetty-launcher-18969-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 2108346 WARN (jetty-launcher-18969-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@38fe9743[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2108347 WARN (jetty-launcher-18969-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@38fe9743[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2108348 INFO (zkCallback-18988-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2108349 INFO (jetty-launcher-18969-thread-1) [n:127.0.0.1:42547_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 2108349 WARN (jetty-launcher-18969-thread-1) [n:127.0.0.1:42547_solr ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 2108357 WARN (jetty-launcher-18969-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@668ba80f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2108357 WARN (jetty-launcher-18969-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@668ba80f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2108358 INFO (jetty-launcher-18969-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:32909/solr
[junit4] 2> 2108368 INFO (jetty-launcher-18969-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2108378 INFO (zkConnectionManagerCallback-19004-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2108378 INFO (jetty-launcher-18969-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2108379 INFO (jetty-launcher-18969-thread-1) [n:127.0.0.1:42547_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 2108401 INFO (jetty-launcher-18969-thread-1) [n:127.0.0.1:42547_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4a09e561
[junit4] 2> 2108410 INFO (jetty-launcher-18969-thread-1) [n:127.0.0.1:42547_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4a09e561
[junit4] 2> 2108410 INFO (jetty-launcher-18969-thread-1) [n:127.0.0.1:42547_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4a09e561
[junit4] 2> 2108411 INFO (jetty-launcher-18969-thread-1) [n:127.0.0.1:42547_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.metrics.reporters.solr.SolrCloudReportersTest_347ADE21146CEAD6-001/tempDir-002/node1
[junit4] 2> 2108495 INFO (jetty-launcher-18969-thread-2) [n:127.0.0.1:36277_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2108495 INFO (zkConnectionManagerCallback-19011-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2108495 INFO (jetty-launcher-18969-thread-2) [n:127.0.0.1:36277_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2108499 WARN (jetty-launcher-18969-thread-2) [n:127.0.0.1:36277_solr ] o.a.s.c.ZkController Contents of zookeeper /security.json are world-readable; consider setting up ACLs as described in https://solr.apache.org/guide/zookeeper-access-control.html
[junit4] 2> 2108500 INFO (jetty-launcher-18969-thread-2) [n:127.0.0.1:36277_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2108511 INFO (jetty-launcher-18969-thread-2) [n:127.0.0.1:36277_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:36277_solr as DOWN
[junit4] 2> 2108512 INFO (jetty-launcher-18969-thread-2) [n:127.0.0.1:36277_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4
[junit4] 2> 2108512 INFO (jetty-launcher-18969-thread-2) [n:127.0.0.1:36277_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:36277_solr
[junit4] 2> 2108513 INFO (zkCallback-18988-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2108513 INFO (zkCallback-19010-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2108514 INFO (jetty-launcher-18969-thread-2) [n:127.0.0.1:36277_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 2108514 WARN (jetty-launcher-18969-thread-2) [n:127.0.0.1:36277_solr ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 2108546 INFO (jetty-launcher-18969-thread-2) [n:127.0.0.1:36277_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 2108565 INFO (jetty-launcher-18969-thread-2) [n:127.0.0.1:36277_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4a09e561
[junit4] 2> 2108575 INFO (jetty-launcher-18969-thread-2) [n:127.0.0.1:36277_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4a09e561
[junit4] 2> 2108575 INFO (jetty-launcher-18969-thread-2) [n:127.0.0.1:36277_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4a09e561
[junit4] 2> 2108576 INFO (jetty-launcher-18969-thread-2) [n:127.0.0.1:36277_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.metrics.reporters.solr.SolrCloudReportersTest_347ADE21146CEAD6-001/tempDir-002/node2
[junit4] 2> 2108591 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2
[junit4] 2> 2108592 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2108593 INFO (zkConnectionManagerCallback-19024-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2108593 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2108594 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 2108595 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:32909/solr ready
[junit4] 2> 2108598 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2108598 INFO (zkConnectionManagerCallback-19026-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2108598 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2108600 WARN (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]-SendThread(127.0.0.1:32909)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10897bc6b1b000a.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10897bc6b1b000a, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x10897bc6b1b000a, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 2108705 INFO (OverseerThreadFactory-18996-thread-1-processing-n:127.0.0.1:42547_solr) [n:127.0.0.1:42547_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection test_collection
[junit4] 2> 2108712 INFO (OverseerThreadFactory-18996-thread-1-processing-n:127.0.0.1:42547_solr) [n:127.0.0.1:42547_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "core":"test_collection_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr",
[junit4] 2> "collection":"test_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 2108714 INFO (OverseerThreadFactory-18996-thread-1-processing-n:127.0.0.1:42547_solr) [n:127.0.0.1:42547_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "core":"test_collection_shard1_replica_n3",
[junit4] 2> "node_name":"127.0.0.1:42547_solr",
[junit4] 2> "base_url":"http://127.0.0.1:42547/solr",
[junit4] 2> "collection":"test_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 2108716 INFO (OverseerThreadFactory-18996-thread-1-processing-n:127.0.0.1:42547_solr) [n:127.0.0.1:42547_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "core":"test_collection_shard2_replica_n5",
[junit4] 2> "node_name":"127.0.0.1:36277_solr",
[junit4] 2> "base_url":"http://127.0.0.1:36277/solr",
[junit4] 2> "collection":"test_collection",
[junit4] 2> "shard":"shard2",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 2108718 INFO (OverseerThreadFactory-18996-thread-1-processing-n:127.0.0.1:42547_solr) [n:127.0.0.1:42547_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "core":"test_collection_shard2_replica_n7",
[junit4] 2> "node_name":"127.0.0.1:42547_solr",
[junit4] 2> "base_url":"http://127.0.0.1:42547/solr",
[junit4] 2> "collection":"test_collection",
[junit4] 2> "shard":"shard2",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 2108728 INFO (qtp508856315-28630) [n:127.0.0.1:36277_solr x:test_collection_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node2&collection.configName=test&newCollection=true&name=test_collection_shard1_replica_n1&action=CREATE&numShards=2&collection=test_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2108728 INFO (qtp508856315-28632) [n:127.0.0.1:36277_solr x:test_collection_shard2_replica_n5 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node6&collection.configName=test&newCollection=true&name=test_collection_shard2_replica_n5&action=CREATE&numShards=2&collection=test_collection&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2108729 INFO (qtp1412036890-28623) [n:127.0.0.1:42547_solr x:test_collection_shard2_replica_n7 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node8&collection.configName=test&newCollection=true&name=test_collection_shard2_replica_n7&action=CREATE&numShards=2&collection=test_collection&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2108729 INFO (qtp1412036890-28623) [n:127.0.0.1:42547_solr x:test_collection_shard2_replica_n7 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4
[junit4] 2> 2108730 INFO (qtp1412036890-28620) [n:127.0.0.1:42547_solr x:test_collection_shard1_replica_n3 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node4&collection.configName=test&newCollection=true&name=test_collection_shard1_replica_n3&action=CREATE&numShards=2&collection=test_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2108753 INFO (qtp508856315-28632) [n:127.0.0.1:36277_solr c:test_collection s:shard2 r:core_node6 x:test_collection_shard2_replica_n5 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
[junit4] 2> 2108754 INFO (qtp508856315-28630) [n:127.0.0.1:36277_solr c:test_collection s:shard1 r:core_node2 x:test_collection_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
[junit4] 2> 2108754 INFO (qtp508856315-28632) [n:127.0.0.1:36277_solr c:test_collection s:shard2 r:core_node6 x:test_collection_shard2_replica_n5 ] o.a.s.s.IndexSchema Schema name=minimal
[junit4] 2> 2108755 WARN (qtp508856315-28632) [n:127.0.0.1:36277_solr c:test_collection s:shard2 r:core_node6 x:test_collection_shard2_replica_n5 ] o.a.s.s.IndexSchema no uniqueKey specified in schema.
[junit4] 2> 2108755 INFO (qtp508856315-28632) [n:127.0.0.1:36277_solr c:test_collection s:shard2 r:core_node6 x:test_collection_shard2_replica_n5 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field null
[junit4] 2> 2108755 INFO (qtp508856315-28632) [n:127.0.0.1:36277_solr c:test_collection s:shard2 r:core_node6 x:test_collection_shard2_replica_n5 ] o.a.s.c.CoreContainer Creating SolrCore 'test_collection_shard2_replica_n5' using configuration from configset test, trusted=true
[junit4] 2> 2108755 INFO (qtp508856315-28630) [n:127.0.0.1:36277_solr c:test_collection s:shard1 r:core_node2 x:test_collection_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema name=minimal
[junit4] 2> 2108755 WARN (qtp508856315-28630) [n:127.0.0.1:36277_solr c:test_collection s:shard1 r:core_node2 x:test_collection_shard1_replica_n1 ] o.a.s.s.IndexSchema no uniqueKey specified in schema.
[junit4] 2> 2108755 INFO (qtp508856315-28630) [n:127.0.0.1:36277_solr c:test_collection s:shard1 r:core_node2 x:test_collection_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field null
[junit4] 2> 2108755 INFO (qtp508856315-28630) [n:127.0.0.1:36277_solr c:test_collection s:shard1 r:core_node2 x:test_collection_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore 'test_collection_shard1_replica_n1' using configuration from configset test, trusted=true
[junit4] 2> 2108755 INFO (qtp508856315-28632) [n:127.0.0.1:36277_solr c:test_collection s:shard2 r:core_node6 x:test_collection_shard2_replica_n5 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.test_collection.shard2.replica_n5' (registry 'solr.core.test_collection.shard2.replica_n5') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4a09e561
[junit4] 2> 2108755 INFO (qtp508856315-28630) [n:127.0.0.1:36277_solr c:test_collection s:shard1 r:core_node2 x:test_collection_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.test_collection.shard1.replica_n1' (registry 'solr.core.test_collection.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4a09e561
[junit4] 2> 2108755 INFO (qtp508856315-28632) [n:127.0.0.1:36277_solr c:test_collection s:shard2 r:core_node6 x:test_collection_shard2_replica_n5 ] o.a.s.c.SolrCore [[test_collection_shard2_replica_n5] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.metrics.reporters.solr.SolrCloudReportersTest_347ADE21146CEAD6-001/tempDir-002/node2/test_collection_shard2_replica_n5], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.metrics.reporters.solr.SolrCloudReportersTest_347ADE21146CEAD6-001/tempDir-002/node2/test_collection_shard2_replica_n5/data/]
[junit4] 2> 2108755 INFO (qtp508856315-28630) [n:127.0.0.1:36277_solr c:test_collection s:shard1 r:core_node2 x:test_collection_shard1_replica_n1 ] o.a.s.c.SolrCore [[test_collection_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.metrics.reporters.solr.SolrCloudReportersTest_347ADE21146CEAD6-001/tempDir-002/node2/test_collection_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.metrics.reporters.solr.SolrCloudReportersTest_347ADE21146CEAD6-001/tempDir-002/node2/test_collection_shard1_replica_n1/data/]
[junit4] 2> 2108759 INFO (qtp1412036890-28620) [n:127.0.0.1:42547_solr c:test_collection s:shard1 r:core_node4 x:test_collection_shard1_replica_n3 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
[junit4] 2> 2108761 INFO (qtp1412036890-28620) [n:127.0.0.1:42547_solr c:test_collection s:shard1 r:core_node4 x:test_collection_shard1_replica_n3 ] o.a.s.s.IndexSchema Schema name=minimal
[junit4] 2> 2108761 WARN (qtp1412036890-28620) [n:127.0.0.1:42547_solr c:test_collection s:shard1 r:core_node4 x:test_collection_shard1_replica_n3 ] o.a.s.s.IndexSchema no uniqueKey specified in schema.
[junit4] 2> 2108761 INFO (qtp1412036890-28620) [n:127.0.0.1:42547_solr c:test_collection s:shard1 r:core_node4 x:test_collection_shard1_replica_n3 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field null
[junit4] 2> 2108761 INFO (qtp1412036890-28620) [n:127.0.0.1:42547_solr c:test_collection s:shard1 r:core_node4 x:test_collection_shard1_replica_n3 ] o.a.s.c.CoreContainer Creating SolrCore 'test_collection_shard1_replica_n3' using configuration from configset test, trusted=true
[junit4] 2> 2108761 INFO (qtp1412036890-28620) [n:127.0.0.1:42547_solr c:test_collection s:shard1 r:core_node4 x:test_collection_shard1_replica_n3 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.test_collection.shard1.replica_n3' (registry 'solr.core.test_collection.shard1.replica_n3') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4a09e561
[junit4] 2> 2108761 INFO (qtp1412036890-28620) [n:127.0.0.1:42547_solr c:test_collection s:shard1 r:core_node4 x:test_collection_shard1_replica_n3 ] o.a.s.c.SolrCore [[test_collection_shard1_replica_n3] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.metrics.reporters.solr.SolrCloudReportersTest_347ADE21146CEAD6-001/tempDir-002/node1/test_collection_shard1_replica_n3], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.metrics.reporters.solr.SolrCloudReportersTest_347ADE21146CEAD6-001/tempDir-002/node1/test_collection_shard1_replica_n3/data/]
[junit4] 2> 2108764 INFO (qtp1412036890-28623) [n:127.0.0.1:42547_solr c:test_collection s:shard2 r:core_node8 x:test_collection_shard2_replica_n7 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
[junit4] 2> 2108770 INFO (qtp1412036890-28623) [n:127.0.0.1:42547_solr c:test_collection s:shard2 r:core_node8 x:test_collection_shard2_replica_n7 ] o.a.s.s.IndexSchema Schema name=minimal
[junit4] 2> 2108770 WARN (qtp1412036890-28623) [n:127.0.0.1:42547_solr c:test_collection s:shard2 r:core_node8 x:test_collection_shard2_replica_n7 ] o.a.s.s.IndexSchema no uniqueKey specified in schema.
[junit4] 2> 2108770 INFO (qtp1412036890-28623) [n:127.0.0.1:42547_solr c:test_collection s:shard2 r:core_node8 x:test_collection_shard2_replica_n7 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field null
[junit4] 2> 2108770 INFO (qtp1412036890-28623) [n:127.0.0.1:42547_solr c:test_collection s:shard2 r:core_node8 x:test_collection_shard2_replica_n7 ] o.a.s.c.CoreContainer Creating SolrCore 'test_collection_shard2_replica_n7' using configuration from configset test, trusted=true
[junit4] 2> 2108770 INFO (qtp1412036890-28623) [n:127.0.0.1:42547_solr c:test_collection s:shard2 r:core_node8 x:test_collection_shard2_replica_n7 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.test_collection.shard2.replica_n7' (registry 'solr.core.test_collection.shard2.replica_n7') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4a09e561
[junit4] 2> 2108770 INFO (qtp1412036890-28623) [n:127.0.0.1:42547_solr c:test_collection s:shard2 r:core_node8 x:test_collection_shard2_replica_n7 ] o.a.s.c.SolrCore [[test_collection_shard2_replica_n7] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.metrics.reporters.solr.SolrCloudReportersTest_347ADE21146CEAD6-001/tempDir-002/node1/test_collection_shard2_replica_n7], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.metrics.reporters.solr.SolrCloudReportersTest_347ADE21146CEAD6-001/tempDir-002/node1/test_collection_shard2_replica_n7/data/]
[junit4] 2> 2108814 INFO (qtp508856315-28632) [n:127.0.0.1:36277_solr c:test_collection s:shard2 r:core_node6 x:test_collection_shard2_replica_n5 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2108814 INFO (qtp508856315-28632) [n:127.0.0.1:36277_solr c:test_collection s:shard2 r:core_node6 x:test_collection_shard2_replica_n5 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2108844 INFO (qtp508856315-28632) [n:127.0.0.1:36277_solr c:test_collection s:shard2 r:core_node6 x:test_collection_shard2_replica_n5 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/test
[junit4] 2> 2108844 INFO (qtp508856315-28632) [n:127.0.0.1:36277_solr c:test_collection s:shard2 r:core_node6 x:test_collection_shard2_replica_n5 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/test
[junit4] 2> 2108845 INFO (qtp508856315-28632) [n:127.0.0.1:36277_solr c:test_collection s:shard2 r:core_node6 x:test_collection_shard2_replica_n5 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 2108848 INFO (qtp508856315-28630) [n:127.0.0.1:36277_solr c:test_collection s:shard1 r:core_node2 x:test_collection_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2108848 INFO (qtp508856315-28630) [n:127.0.0.1:36277_solr c:test_collection s:shard1 r:core_node2 x:test_collection_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2108850 INFO (qtp1412036890-28620) [n:127.0.0.1:42547_solr c:test_collection s:shard1 r:core_node4 x:test_collection_shard1_replica_n3 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2108850 INFO (qtp1412036890-28620) [n:127.0.0.1:42547_solr c:test_collection s:shard1 r:core_node4 x:test_collection_shard1_replica_n3 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2108850 INFO (searcherExecutor-19028-thread-1-processing-n:127.0.0.1:36277_solr x:test_collection_shard2_replica_n5 c:test_collection s:shard2 r:core_node6) [n:127.0.0.1:36277_solr c:test_collection s:shard2 r:core_node6 x:test_collection_shard2_replica_n5 ] o.a.s.c.SolrCore [test_collection_shard2_replica_n5] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2108850 INFO (qtp1412036890-28623) [n:127.0.0.1:42547_solr c:test_collection s:shard2 r:core_node8 x:test_collection_shard2_replica_n7 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2108850 INFO (qtp1412036890-28623) [n:127.0.0.1:42547_solr c:test_collection s:shard2 r:core_node8 x:test_collection_shard2_replica_n7 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2108858 INFO (qtp508856315-28630) [n:127.0.0.1:36277_solr c:test_collection s:shard1 r:core_node2 x:test_collection_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/test
[junit4] 2> 2108858 INFO (qtp1412036890-28620) [n:127.0.0.1:42547_solr c:test_collection s:shard1 r:core_node4 x:test_collection_shard1_replica_n3 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/test
[junit4] 2> 2108858 INFO (qtp1412036890-28623) [n:127.0.0.1:42547_solr c:test_collection s:shard2 r:core_node8 x:test_collection_shard2_replica_n7 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/test
[junit4] 2> 2108859 INFO (qtp1412036890-28620) [n:127.0.0.1:42547_solr c:test_collection s:shard1 r:core_node4 x:test_collection_shard1_replica_n3 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/test
[junit4] 2> 2108859 INFO (qtp1412036890-28620) [n:127.0.0.1:42547_solr c:test_collection s:shard1 r:core_node4 x:test_collection_shard1_replica_n3 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 2108859 INFO (qtp1412036890-28623) [n:127.0.0.1:42547_solr c:test_collection s:shard2 r:core_node8 x:test_collection_shard2_replica_n7 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/test
[junit4] 2> 2108860 INFO (qtp1412036890-28623) [n:127.0.0.1:42547_solr c:test_collection s:shard2 r:core_node8 x:test_collection_shard2_replica_n7 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 2108860 INFO (qtp508856315-28630) [n:127.0.0.1:36277_solr c:test_collection s:shard1 r:core_node2 x:test_collection_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/test
[junit4] 2> 2108860 INFO (qtp508856315-28630) [n:127.0.0.1:36277_solr c:test_collection s:shard1 r:core_node2 x:test_collection_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 2108867 INFO (searcherExecutor-19030-thread-1-processing-n:127.0.0.1:36277_solr x:test_collection_shard1_replica_n1 c:test_collection s:shard1 r:core_node2) [n:127.0.0.1:36277_solr c:test_collection s:shard1 r:core_node2 x:test_collection_shard1_replica_n1 ] o.a.s.c.SolrCore [test_collection_shard1_replica_n1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2108868 INFO (searcherExecutor-19032-thread-1-processing-n:127.0.0.1:42547_solr x:test_collection_shard1_replica_n3 c:test_collection s:shard1 r:core_node4) [n:127.0.0.1:42547_solr c:test_collection s:shard1 r:core_node4 x:test_collection_shard1_replica_n3 ] o.a.s.c.SolrCore [test_collection_shard1_replica_n3] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2108868 INFO (searcherExecutor-19034-thread-1-processing-n:127.0.0.1:42547_solr x:test_collection_shard2_replica_n7 c:test_collection s:shard2 r:core_node8) [n:127.0.0.1:42547_solr c:test_collection s:shard2 r:core_node8 x:test_collection_shard2_replica_n7 ] o.a.s.c.SolrCore [test_collection_shard2_replica_n7] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2108870 INFO (qtp508856315-28632) [n:127.0.0.1:36277_solr c:test_collection s:shard2 r:core_node6 x:test_collection_shard2_replica_n5 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/test_collection/terms/shard2 to Terms{values={core_node6=0}, version=0}
[junit4] 2> 2108870 INFO (qtp508856315-28632) [n:127.0.0.1:36277_solr c:test_collection s:shard2 r:core_node6 x:test_collection_shard2_replica_n5 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/test_collection/leaders/shard2
[junit4] 2> 2108872 INFO (qtp1412036890-28623) [n:127.0.0.1:42547_solr c:test_collection s:shard2 r:core_node8 x:test_collection_shard2_replica_n7 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/test_collection/terms/shard2 to Terms{values={core_node6=0, core_node8=0}, version=1}
[junit4] 2> 2108872 INFO (qtp1412036890-28623) [n:127.0.0.1:42547_solr c:test_collection s:shard2 r:core_node8 x:test_collection_shard2_replica_n7 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/test_collection/leaders/shard2
[junit4] 2> 2108874 INFO (qtp508856315-28630) [n:127.0.0.1:36277_solr c:test_collection s:shard1 r:core_node2 x:test_collection_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/test_collection/terms/shard1 to Terms{values={core_node2=0}, version=0}
[junit4] 2> 2108874 INFO (qtp508856315-28630) [n:127.0.0.1:36277_solr c:test_collection s:shard1 r:core_node2 x:test_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/test_collection/leaders/shard1
[junit4] 2> 2108876 INFO (qtp1412036890-28620) [n:127.0.0.1:42547_solr c:test_collection s:shard1 r:core_node4 x:test_collection_shard1_replica_n3 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/test_collection/terms/shard1 to Terms{values={core_node2=0, core_node4=0}, version=1}
[junit4] 2> 2108876 INFO (qtp1412036890-28620) [n:127.0.0.1:42547_solr c:test_collection s:shard1 r:core_node4 x:test_collection_shard1_replica_n3 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/test_collection/leaders/shard1
[junit4] 2> 2108876 INFO (qtp508856315-28632) [n:127.0.0.1:36277_solr c:test_collection s:shard2 r:core_node6 x:test_collection_shard2_replica_n5 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 2108876 INFO (qtp508856315-28632) [n:127.0.0.1:36277_solr c:test_collection s:shard2 r:core_node6 x:test_collection_shard2_replica_n5 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 2108876 INFO (qtp508856315-28632) [n:127.0.0.1:36277_solr c:test_collection s:shard2 r:core_node6 x:test_collection_shard2_replica_n5 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:36277/solr/test_collection_shard2_replica_n5/
[junit4] 2> 2108876 ERROR (qtp508856315-28632) [n:127.0.0.1:36277_solr c:test_collection s:shard2 r:core_node6 x:test_collection_shard2_replica_n5 ] o.a.s.c.SyncStrategy No UpdateLog found - cannot sync
[junit4] 2> 2108876 INFO (qtp508856315-28632) [n:127.0.0.1:36277_solr c:test_collection s:shard2 r:core_node6 x:test_collection_shard2_replica_n5 ] o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 2108876 INFO (qtp508856315-28632) [n:127.0.0.1:36277_solr c:test_collection s:shard2 r:core_node6 x:test_collection_shard2_replica_n5 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/test_collection/leaders/shard2/leader after winning as /collections/test_collection/leader_elect/shard2/election/74476229358190600-core_node6-n_0000000000
[junit4] 2> 2108879 INFO (qtp508856315-28632) [n:127.0.0.1:36277_solr c:test_collection s:shard2 r:core_node6 x:test_collection_shard2_replica_n5 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:36277/solr/test_collection_shard2_replica_n5/ shard2
[junit4] 2> 2108881 INFO (qtp508856315-28630) [n:127.0.0.1:36277_solr c:test_collection s:shard1 r:core_node2 x:test_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 2108881 INFO (qtp508856315-28630) [n:127.0.0.1:36277_solr c:test_collection s:shard1 r:core_node2 x:test_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 2108881 INFO (qtp508856315-28630) [n:127.0.0.1:36277_solr c:test_collection s:shard1 r:core_node2 x:test_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:36277/solr/test_collection_shard1_replica_n1/
[junit4] 2> 2108881 ERROR (qtp508856315-28630) [n:127.0.0.1:36277_solr c:test_collection s:shard1 r:core_node2 x:test_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy No UpdateLog found - cannot sync
[junit4] 2> 2108881 INFO (qtp508856315-28630) [n:127.0.0.1:36277_solr c:test_collection s:shard1 r:core_node2 x:test_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 2108881 INFO (qtp508856315-28630) [n:127.0.0.1:36277_solr c:test_collection s:shard1 r:core_node2 x:test_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/test_collection/leaders/shard1/leader after winning as /collections/test_collection/leader_elect/shard1/election/74476229358190600-core_node2-n_0000000000
[junit4] 2> 2108883 INFO (qtp508856315-28632) [n:127.0.0.1:36277_solr c:test_collection s:shard2 r:core_node6 x:test_collection_shard2_replica_n5 ] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 2108883 INFO (qtp508856315-28630) [n:127.0.0.1:36277_solr c:test_collection s:shard1 r:core_node2 x:test_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:36277/solr/test_collection_shard1_replica_n1/ shard1
[junit4] 2> 2108884 INFO (zkCallback-19010-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections/test_collection/state.json] for collection [test_collection] has occurred - updating... (live nodes size: [2])
[junit4] 2> 2108886 INFO (qtp508856315-28630) [n:127.0.0.1:36277_solr c:test_collection s:shard1 r:core_node2 x:test_collection_shard1_replica_n1 ] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 2108887 INFO (zkCallback-19010-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections/test_collection/state.json] for collection [test_collection] has occurred - updating... (live nodes size: [2])
[junit4] 2> 2108888 INFO (qtp508856315-28632) [n:127.0.0.1:36277_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node6&collection.configName=test&newCollection=true&name=test_collection_shard2_replica_n5&action=CREATE&numShards=2&collection=test_collection&shard=shard2&wt=javabin&version=2&replicaType=NRT} status=0 QTime=159
[junit4] 2> 2108889 INFO (qtp508856315-28630) [n:127.0.0.1:36277_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=test&newCollection=true&name=test_collection_shard1_replica_n1&action=CREATE&numShards=2&collection=test_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=161
[junit4] 2> 2109881 INFO (zkCallback-19010-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections/test_collection/state.json] for collection [test_collection] has occurred - updating... (live nodes size: [2])
[junit4] 2> 2109883 INFO (zkCallback-19010-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections/test_collection/state.json] for collection [test_collection] has occurred - updating... (live nodes size: [2])
[junit4] 2> 2109883 INFO (zkCallback-18988-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections/test_collection/state.json] for collection [test_collection] has occurred - updating... (live nodes size: [2])
[junit4] 2> 2109884 INFO (qtp1412036890-28623) [n:127.0.0.1:42547_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node8&collection.configName=test&newCollection=true&name=test_collection_shard2_replica_n7&action=CREATE&numShards=2&collection=test_collection&shard=shard2&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1155
[junit4] 2> 2109885 INFO (qtp1412036890-28620) [n:127.0.0.1:42547_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=test&newCollection=true&name=test_collection_shard1_replica_n3&action=CREATE&numShards=2&collection=test_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1154
[junit4] 2> 2109887 INFO (qtp1412036890-28621) [n:127.0.0.1:42547_solr ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 2109887 INFO (qtp1412036890-28621) [n:127.0.0.1:42547_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=test&maxShardsPerNode=4&name=test_collection&nrtReplicas=2&action=CREATE&numShards=2&perReplicaState=true&wt=javabin&version=2} status=0 QTime=1185
[junit4] 2> 2109888 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection: test_collection
[junit4] 2> 2109890 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.SolrCloudTestCase waitForState (test_collection): Expected test_collection with 2 shards and 2 replicas
[junit4] 2> 2109891 INFO (watches-19021-thread-1) [ ] o.a.s.c.SolrCloudTestCase active replica count: 4 expected replica count: 4
[junit4] 2> 2109892 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 4 expected replica count: 4
[junit4] 2> 2109892 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 4 expected replica count: 4
[junit4] 2> 2109892 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 4 expected replica count: 4
[junit4] 2> 2109894 INFO (TEST-SolrCloudReportersTest.testDefaultPlugins-seed#[347ADE21146CEAD6]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testDefaultPlugins
[junit4] 2> 2109925 INFO (TEST-SolrCloudReportersTest.testExplicitConfiguration-seed#[347ADE21146CEAD6]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testExplicitConfiguration
[junit4] 2> 2110027 INFO (jetty-closer-19047-thread-1) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1486793747
[junit4] 2> 2110027 INFO (jetty-closer-19047-thread-1) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:42547_solr
[junit4] 2> 2110027 INFO (jetty-closer-19047-thread-1) [ ] o.a.s.c.ZkController Publish this node as DOWN...
[junit4] 2> 2110027 INFO (jetty-closer-19047-thread-1) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:42547_solr as DOWN
[junit4] 2> 2110031 INFO (jetty-closer-19047-thread-2) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=852442488
[junit4] 2> 2110031 INFO (jetty-closer-19047-thread-2) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:36277_solr
[junit4] 2> 2110032 INFO (zkCallback-19010-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections/test_collection/state.json] for collection [test_collection] has occurred - updating... (live nodes size: [2])
[junit4] 2> 2110032 INFO (jetty-closer-19047-thread-2) [ ] o.a.s.c.ZkController Publish this node as DOWN...
[junit4] 2> 2110032 INFO (zkCallback-18988-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections/test_collection/state.json] for collection [test_collection] has occurred - updating... (live nodes size: [2])
[junit4] 2> 2110032 INFO (jetty-closer-19047-thread-2) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:36277_solr as DOWN
[junit4] 2> 2110036 INFO (zkCallback-19010-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections/test_collection/state.json] for collection [test_collection] has occurred - updating... (live nodes size: [2])
[junit4] 2> 2110037 INFO (zkCallback-18988-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections/test_collection/state.json] for collection [test_collection] has occurred - updating... (live nodes size: [2])
[junit4] 2> 2110038 INFO (coreCloseExecutor-19053-thread-1) [n:127.0.0.1:42547_solr ] o.a.s.c.SolrCore [test_collection_shard1_replica_n3] CLOSING SolrCore org.apache.solr.core.SolrCore@9c55e33
[junit4] 2> 2110038 INFO (coreCloseExecutor-19053-thread-1) [n:127.0.0.1:42547_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.test_collection.shard1.replica_n3 tag=SolrCore@9c55e33
[junit4] 2> 2110038 INFO (coreCloseExecutor-19053-thread-1) [n:127.0.0.1:42547_solr ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6687d714: rootName = null, domain = solr.core.test_collection.shard1.replica_n3, service url = null, agent id = null] for registry solr.core.test_collection.shard1.replica_n3/com.codahale.metrics.MetricRegistry@7854b8cf
[junit4] 2> 2110046 INFO (coreCloseExecutor-19053-thread-2) [n:127.0.0.1:42547_solr ] o.a.s.c.SolrCore [test_collection_shard2_replica_n7] CLOSING SolrCore org.apache.solr.core.SolrCore@29e10ff0
[junit4] 2> 2110050 INFO (coreCloseExecutor-19055-thread-1) [n:127.0.0.1:36277_solr ] o.a.s.c.SolrCore [test_collection_shard2_replica_n5] CLOSING SolrCore org.apache.solr.core.SolrCore@2cb501ef
[junit4] 2> 2110050 INFO (coreCloseExecutor-19055-thread-1) [n:127.0.0.1:36277_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.test_collection.shard2.replica_n5 tag=SolrCore@2cb501ef
[junit4] 2> 2110050 INFO (coreCloseExecutor-19055-thread-2) [n:127.0.0.1:36277_solr ] o.a.s.c.SolrCore [test_collection_shard1_replica_n1] CLOSING SolrCore org.apache.solr.core.SolrCore@412375f4
[junit4] 2> 2110050 INFO (coreCloseExecutor-19055-thread-1) [n:127.0.0.1:36277_solr ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@48a43422: rootName = null, domain = solr.core.test_collection.shard2.replica_n5, service url = null, agent id = null] for registry solr.core.test_collection.shard2.replica_n5/com.codahale.metrics.MetricRegistry@3e422949
[junit4] 2> 2110060 INFO (coreCloseExecutor-19053-thread-1) [n:127.0.0.1:42547_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.test_collection.shard1.leader tag=SolrCore@9c55e33
[junit4] 2> 2110060 INFO (coreCloseExecutor-19053-thread-2) [n:127.0.0.1:42547_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.test_collection.shard2.replica_n7 tag=SolrCore@29e10ff0
[junit4] 2> 2110060 INFO (coreCloseExecutor-19053-thread-2) [n:127.0.0.1:42547_solr ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3449d4a4: rootName = null, domain = solr.core.test_collection.shard2.replica_n7, service url = null, agent id = null] for registry solr.core.test_collection.shard2.replica_n7/com.codahale.metrics.MetricRegistry@62304f1a
[junit4] 2> 2110061 INFO (coreCloseExecutor-19053-thread-1) [n:127.0.0.1:42547_solr ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED (unnecessary).
[junit4] 2> 2110075 INFO (coreCloseExecutor-19055-thread-1) [n:127.0.0.1:36277_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.test_collection.shard2.leader tag=SolrCore@2cb501ef
[junit4] 2> 2110076 INFO (coreCloseExecutor-19055-thread-1) [n:127.0.0.1:36277_solr ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED (unnecessary).
[junit4] 2> 2110077 INFO (coreCloseExecutor-19053-thread-2) [n:127.0.0.1:42547_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.test_collection.shard2.leader tag=SolrCore@29e10ff0
[junit4] 2> 2110078 INFO (coreCloseExecutor-19053-thread-2) [n:127.0.0.1:42547_solr ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED (unnecessary).
[junit4] 2> 2110082 INFO (coreCloseExecutor-19055-thread-2) [n:127.0.0.1:36277_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.test_collection.shard1.replica_n1 tag=SolrCore@412375f4
[junit4] 2> 2110082 INFO (coreCloseExecutor-19055-thread-2) [n:127.0.0.1:36277_solr ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3984c1ff: rootName = null, domain = solr.core.test_collection.shard1.replica_n1, service url = null, agent id = null] for registry solr.core.test_collection.shard1.replica_n1/com.codahale.metrics.MetricRegistry@1019b56c
[junit4] 2> 2110086 INFO (jetty-closer-19047-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
[junit4] 2> 2110086 INFO (jetty-closer-19047-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@77896b1a: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@4d0fe2bd
[junit4] 2> 2110092 INFO (jetty-closer-19047-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
[junit4] 2> 2110092 INFO (jetty-closer-19047-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@946f26b: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@b6ede6f
[junit4] 2> 2110095 INFO (jetty-closer-19047-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 2110095 INFO (jetty-closer-19047-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3443032d: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@342717c3
[junit4] 2> 2110095 INFO (jetty-closer-19047-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster tag=null
[junit4] 2> 2110097 INFO (coreCloseExecutor-19055-thread-2) [n:127.0.0.1:36277_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.test_collection.shard1.leader tag=SolrCore@412375f4
[junit4] 2> 2110098 INFO (coreCloseExecutor-19055-thread-2) [n:127.0.0.1:36277_solr ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED (unnecessary).
[junit4] 2> 2110101 INFO (closeThreadPool-19057-thread-2) [ ] o.a.s.c.Overseer Overseer (id=74476229358190598-127.0.0.1:42547_solr-n_0000000000) closing
[junit4] 2> 2110102 INFO (jetty-closer-19047-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
[junit4] 2> 2110102 INFO (jetty-closer-19047-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2d0699de: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@5c3f5216
[junit4] 2> 2110102 INFO (OverseerStateUpdate-74476229358190598-127.0.0.1:42547_solr-n_0000000000) [n:127.0.0.1:42547_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:42547_solr
[junit4] 2> 2110106 INFO (OverseerAutoScalingTriggerThread-74476229358190598-127.0.0.1:42547_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 2110111 INFO (closeThreadPool-19057-thread-1) [ ] o.a.s.c.Overseer Overseer (id=74476229358190598-127.0.0.1:42547_solr-n_0000000000) closing
[junit4] 2> 2110111 WARN (jetty-launcher-18969-thread-1-SendThread(127.0.0.1:32909)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10897bc6b1b0006.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10897bc6b1b0006, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x10897bc6b1b0006, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 2110112 INFO (zkCallback-19010-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 2110113 INFO (jetty-closer-19047-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
[junit4] 2> 2110113 INFO (jetty-closer-19047-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@12e3a5a4: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@b6ede6f
[junit4] 2> 2110118 INFO (jetty-closer-19047-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 2110118 INFO (jetty-closer-19047-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@79509c4c: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@342717c3
[junit4] 2> 2110118 INFO (jetty-closer-19047-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster tag=null
[junit4] 2> 2110212 INFO (jetty-closer-19047-thread-1) [ ] o.a.s.c.Overseer Overseer (id=74476229358190598-127.0.0.1:42547_solr-n_0000000000) closing
[junit4] 2> 2110213 INFO (jetty-closer-19047-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@5aee0def{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 2110213 INFO (jetty-closer-19047-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@15544bc8{/solr,null,STOPPED}
[junit4] 2> 2110213 INFO (jetty-closer-19047-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2110313 INFO (jetty-closer-19047-thread-2) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@10936a41{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 2110313 INFO (jetty-closer-19047-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@6c11d3dc{/solr,null,STOPPED}
[junit4] 2> 2110313 INFO (jetty-closer-19047-thread-2) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2110314 INFO (TEST-SolrCloudReportersTest.testExplicitConfiguration-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 2110516 WARN (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 5 /solr/collections/test_collection/terms/shard2
[junit4] 2> 5 /solr/collections/test_collection/terms/shard1
[junit4] 2> 3 /solr/aliases.json
[junit4] 2> 3 /solr/clusterprops.json
[junit4] 2> 2 /solr/configs/test
[junit4] 2> 2 /solr/packages.json
[junit4] 2> 2 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 13 /solr/collections/test_collection/state.json
[junit4] 2> 3 /solr/clusterstate.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 22 /solr/collections/test_collection/state.json
[junit4] 2> 13 /solr/overseer/queue
[junit4] 2> 7 /solr/live_nodes
[junit4] 2> 6 /solr/collections
[junit4] 2> 5 /solr/overseer/collection-queue-work
[junit4] 2>
[junit4] 2> 2110518 INFO (TEST-SolrCloudReportersTest.testExplicitConfiguration-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:32909
[junit4] 2> 2110518 INFO (TEST-SolrCloudReportersTest.testExplicitConfiguration-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:32909
[junit4] 2> 2110518 INFO (TEST-SolrCloudReportersTest.testExplicitConfiguration-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 32909
[junit4] 2> 2110519 INFO (TEST-SolrCloudReportersTest.testExplicitConfiguration-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.metrics.reporters.solr.SolrCloudReportersTest_347ADE21146CEAD6-001/tempDir-003
[junit4] 2> 2110519 INFO (TEST-SolrCloudReportersTest.testExplicitConfiguration-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2110520 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 2110520 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 2110521 WARN (ZkTestServer Run Thread) [ ] o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
[junit4] 2> 2110620 INFO (TEST-SolrCloudReportersTest.testExplicitConfiguration-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.ZkTestServer start zk server on port: 43747
[junit4] 2> 2110620 INFO (TEST-SolrCloudReportersTest.testExplicitConfiguration-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:43747
[junit4] 2> 2110620 INFO (TEST-SolrCloudReportersTest.testExplicitConfiguration-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:43747
[junit4] 2> 2110620 INFO (TEST-SolrCloudReportersTest.testExplicitConfiguration-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 43747
[junit4] 2> 2110622 INFO (TEST-SolrCloudReportersTest.testExplicitConfiguration-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2110630 INFO (zkConnectionManagerCallback-19061-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2110630 INFO (TEST-SolrCloudReportersTest.testExplicitConfiguration-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2110640 INFO (TEST-SolrCloudReportersTest.testExplicitConfiguration-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2110648 INFO (zkConnectionManagerCallback-19063-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2110648 INFO (TEST-SolrCloudReportersTest.testExplicitConfiguration-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2110649 INFO (TEST-SolrCloudReportersTest.testExplicitConfiguration-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2110650 INFO (zkConnectionManagerCallback-19065-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2110650 INFO (TEST-SolrCloudReportersTest.testExplicitConfiguration-seed#[347ADE21146CEAD6]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2110752 INFO (jetty-launcher-19066-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 2110752 INFO (jetty-launcher-19066-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 2110752 INFO (jetty-launcher-19066-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 2110752 INFO (jetty-launcher-19066-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 2110752 INFO (jetty-launcher-19066-thread-1) [ ] o.e.j.s.Server jetty-9.4.44.v20210927; built: 2021-09-27T23:02:44.612Z; git: 8da83308eeca865e495e53ef315a249d63ba9332; jvm 1.8.0_291-b10
[junit4] 2> 2110752 INFO (jetty-launcher-19066-thread-2) [ ] o.e.j.s.Server jetty-9.4.44.v20210927; built: 2021-09-27T23:02:44.612Z; git: 8da83308eeca865e495e53ef315a249d63ba9332; jvm 1.8.0_291-b10
[junit4] 2> 2110754 INFO (jetty-launcher-19066-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2110754 INFO (jetty-launcher-19066-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2110754 INFO (jetty-launcher-19066-thread-2) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2110758 INFO (jetty-launcher-19066-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2110758 INFO (jetty-launcher-19066-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2110758 INFO (jetty-launcher-19066-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2110758 INFO (jetty-launcher-19066-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6e49d2d2{/solr,null,AVAILABLE}
[junit4] 2> 2110758 INFO (jetty-launcher-19066-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1cbe066b{/solr,null,AVAILABLE}
[junit4] 2> 2110758 INFO (jetty-launcher-19066-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@374e3a9f{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:37351}
[junit4] 2> 2110758 INFO (jetty-launcher-19066-thread-2) [ ] o.e.j.s.Server Started @2110789ms
[junit4] 2> 2110758 INFO (jetty-launcher-19066-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, zkHost=127.0.0.1:43747/solr, hostPort=37351}
[junit4] 2> 2110759 INFO (jetty-launcher-19066-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@6f2bb324{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:37459}
[junit4] 2> 2110759 INFO (jetty-launcher-19066-thread-1) [ ] o.e.j.s.Server Started @2110789ms
[junit4] 2> 2110759 INFO (jetty-launcher-19066-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, zkHost=127.0.0.1:43747/solr, hostPort=37459}
[junit4] 2> 2110759 ERROR (jetty-launcher-19066-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2110759
[...truncated too long message...]
ContextHandler Stopped o.e.j.s.ServletContextHandler@1cbe066b{/solr,null,STOPPED}
[junit4] 2> 2123278 INFO (jetty-closer-19144-thread-2-processing-n:127.0.0.1:37351_solr) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2123377 INFO (jetty-closer-19144-thread-1-processing-n:127.0.0.1:37351_solr) [ ] o.a.s.c.Overseer Overseer (id=74476229545820166-127.0.0.1:37351_solr-n_0000000000) closing
[junit4] 2> 2123378 INFO (jetty-closer-19144-thread-1-processing-n:127.0.0.1:37351_solr) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@374e3a9f{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 2123379 INFO (jetty-closer-19144-thread-1-processing-n:127.0.0.1:37351_solr) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@6e49d2d2{/solr,null,STOPPED}
[junit4] 2> 2123379 INFO (jetty-closer-19144-thread-1-processing-n:127.0.0.1:37351_solr) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2123379 INFO (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker) [n:127.0.0.1:37351_solr ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 2123481 WARN (TEST-SolrCloudReportersTest.testExplicitConfiguration-seed#[347ADE21146CEAD6]-SendThread(127.0.0.1:43747)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10897bc764a0001.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10897bc764a0001, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x10897bc764a0001, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 2123583 WARN (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 5 /solr/collections/test_collection/terms/shard2
[junit4] 2> 5 /solr/collections/test_collection/terms/shard1
[junit4] 2> 3 /solr/aliases.json
[junit4] 2> 3 /solr/clusterprops.json
[junit4] 2> 2 /solr/configs/test
[junit4] 2> 2 /solr/packages.json
[junit4] 2> 2 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 12 /solr/collections/test_collection/state.json
[junit4] 2> 3 /solr/clusterstate.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 26 /solr/collections/test_collection/state.json
[junit4] 2> 11 /solr/overseer/queue
[junit4] 2> 6 /solr/live_nodes
[junit4] 2> 6 /solr/collections
[junit4] 2> 5 /solr/overseer/collection-queue-work
[junit4] 2>
[junit4] 2> 2123585 INFO (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker) [n:127.0.0.1:37351_solr ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:43747
[junit4] 2> 2123585 INFO (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker) [n:127.0.0.1:37351_solr ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:43747
[junit4] 2> 2123585 INFO (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker) [n:127.0.0.1:37351_solr ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 43747
[junit4] 2> 2123586 INFO (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker) [n:127.0.0.1:37351_solr ] o.a.s.u.ErrorLogMuter Closing ErrorLogMuter-regex-504 after mutting 0 log messages
[junit4] 2> 2123586 INFO (SUITE-SolrCloudReportersTest-seed#[347ADE21146CEAD6]-worker) [n:127.0.0.1:37351_solr ] o.a.s.u.ErrorLogMuter Creating ErrorLogMuter-regex-505 for ERROR logs matching regex: ignore_exception
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.metrics.reporters.solr.SolrCloudReportersTest_347ADE21146CEAD6-001
[junit4] 2> Nov 02, 2021 1:21:08 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene87): {}, docValues:{}, maxPointsInLeafNode=455, maxMBSortInHeap=5.228945928053898, sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=cs, timezone=Europe/Athens
[junit4] 2> NOTE: Linux 5.4.0-45-generic amd64/Oracle Corporation 1.8.0_291 (64-bit)/cpus=4,threads=1,free=166331392,total=522190848
[junit4] 2> NOTE: All tests run in this JVM: [TestLuceneIndexBackCompat, InfixSuggestersTest, TestInPlaceUpdatesRequiredField, TestFieldCacheSort, SpellingQueryConverterTest, TestStressThreadBackup, PrimUtilsTest, OverseerSolrResponseTest, DistributedFacetPivotLongTailTest, TestAnalyzedSuggestions, CoreAdminCreateDiscoverTest, CollectionReloadTest, IndexSizeTriggerSizeEstimationTest, ShardsWhitelistTest, TestUpdate, TestNoOpRegenerator, OpenExchangeRatesOrgProviderTest, OverriddenZkACLAndCredentialsProvidersTest, TestCircuitBreaker, TestDocTermOrds, DocValuesTest, TestSolr4Spatial, TestStandardQParsers, SuggesterTSTTest, HLLSerializationTest, TestDFISimilarityFactory, SolrTestCaseJ4Test, HighlighterConfigTest, MoveReplicaHDFSFailoverTest, TestPseudoReturnFields, FieldAnalysisRequestHandlerTest, TestRestManager, TestFuzzyAnalyzedSuggestions, TriggerSetPropertiesIntegrationTest, RecoveryZkTest, TestManagedSynonymFilterFactory, TestSchemaField, ReturnFieldsTest, ExecutePlanActionTest, NodeMarkersRegistrationTest, HttpSolrCallGetCoreTest, ZookeeperReadAPITest, SpatialFilterTest, TestLegacyTerms, TestScoreJoinQPScore, DistributedDebugComponentTest, CloudReplicaSourceTest, TestOrdValues, TestSimLargeCluster, TestReplicationHandler, TestDocBasedVersionConstraints, TestRemoteStreaming, VersionInfoTest, TestTrackingShardHandlerFactory, TestConfigsApi, SuggestComponentTest, TestGraphMLResponseWriter, TestBinaryResponseWriter, TestTextField, IndexSchemaTest, DeleteNodeTest, MultiThreadedOCPTest, TestInitQParser, DistributedVersionInfoTest, TestLMJelinekMercerSimilarityFactory, TestDynamicFieldResource, TestTlogReplica, TestConfigSetImmutable, TestMacroExpander, TestCloudSearcherWarming, TestPolicyCloud, TestCustomSort, MetricsDisabledCloudTest, TestStressUserVersions, AliasIntegrationTest, CdcrReplicationHandlerTest, TestCloudJSONFacetSKG, TestExceedMaxTermLength, TestSimScenario, TestSchemaVersionResource, DistributedMLTComponentTest, HdfsBackupRepositoryIntegrationTest, DOMUtilTest, HdfsChaosMonkeySafeLeaderTest, TestFoldingMultitermQuery, PeerSyncTest, IndexBasedSpellCheckerTest, TestSSLRandomization, TestCollapseQParserPlugin, NodeAddedTriggerIntegrationTest, TestHighlightDedupGrouping, XmlUpdateRequestHandlerTest, RuleEngineTest, RegexBoostProcessorTest, GraphQueryTest, TestDistribDocBasedVersion, DocExpirationUpdateProcessorFactoryTest, BaseCdcrDistributedZkTest, DeleteByIdWithRouterFieldTest, BooleanFieldTest, CreateCollectionCleanupTest, TestDistribIDF, TestSimDistributedQueue, BlobRepositoryCloudTest, TestLegacyFieldCache, TolerantUpdateProcessorTest, DateFieldTest, PeerSyncWithLeaderTest, TestPerFieldSimilarityWithDefaultOverride, TestSearchPerf, TestCloudPivotFacet, OutputWriterTest, FullSolrCloudDistribCmdsTest, TestRecovery, TestStressCloudBlindAtomicUpdates, SplitShardTest, LeaderFailoverAfterPartitionTest, LegacyCloudClusterPropTest, MetricsHistoryWithAuthIntegrationTest, MigrateRouteKeyTest, RestartWhileUpdatingTest, RollingRestartTest, ShardTermsTest, SharedFSAutoReplicaFailoverTest, SliceStateTest, SolrCLIZkUtilsTest, SolrCloudExampleTest, TestConfigSetsAPIZkFailure, TestCryptoKeys, TestLeaderElectionWithEmptyReplica, TestPrepRecovery, TestRandomFlRTGCloud, TestRebalanceLeaders, TriLevelCompositeIdRoutingTest, UnloadDistributedZkTest, ZkSolrClientTest, PurgeGraphTest, ShardSplitTest, ZkStateWriterTest, SolrCoreTest, TestCorePropertiesReload, TestDynamicLoadingUrl, TestInitParams, TestJmxIntegration, TestMinimalConfig, TestNRTOpen, TestQuerySenderListener, TestShardHandlerFactory, TestSimpleTextCodec, TestSolrConfigHandler, RequestLoggingTest, TestConfigReload, TestIncrementalCoreBackup, TestSQLHandlerNonCloud, TestSnapshotCoreBackup, TestStressIncrementalBackup, InfoHandlerTest, LoggingHandlerTest, MBeansHandlerTest, FacetPivotSmallTest, ResponseBuilderTest, ResponseLogComponentTest, TermsComponentTest, TestExpandComponent, TestHttpShardHandlerFactory, TestPivotHelperCode, TestSchemaDesignerConfigSetHelper, TestNumericRangeQuery64, SolrGraphiteReporterTest, SolrCloudReportersTest]
[junit4] Completed [764/951 (1!)] on J0 in 17.52s, 2 tests, 1 failure <<< FAILURES!
[...truncated 54884 lines...]
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:619: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:492: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:479: Source checkout is dirty (unversioned/missing files) after running tests!!! Offending files:
* solr/licenses/annotations-2.17.63.jar.sha1
Total time: 75 minutes 46 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
[Checks API] No suitable checks publisher found.
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
[JENKINS] Lucene » Lucene-Solr-Tests-8.x - Build # 3456 - Still Failing!
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.x/3456/
All tests passed
Build Log:
[...truncated 70781 lines...]
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:619: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:492: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:479: Source checkout is dirty (unversioned/missing files) after running tests!!! Offending files:
* solr/licenses/annotations-2.17.63.jar.sha1
Total time: 74 minutes 36 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
[Checks API] No suitable checks publisher found.
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
[JENKINS] Lucene » Lucene-Solr-Tests-8.x - Build # 3455 - Still Failing!
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.x/3455/
All tests passed
Build Log:
[...truncated 70796 lines...]
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:619: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:492: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:479: Source checkout is dirty (unversioned/missing files) after running tests!!! Offending files:
* solr/licenses/annotations-2.17.63.jar.sha1
Total time: 79 minutes 23 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
[Checks API] No suitable checks publisher found.
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
[JENKINS] Lucene » Lucene-Solr-Tests-8.x - Build # 3454 - Still Failing!
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.x/3454/
All tests passed
Build Log:
[...truncated 70763 lines...]
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:619: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:492: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:479: Source checkout is dirty (unversioned/missing files) after running tests!!! Offending files:
* solr/licenses/annotations-2.17.63.jar.sha1
Total time: 73 minutes 54 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
[Checks API] No suitable checks publisher found.
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
[JENKINS] Lucene » Lucene-Solr-Tests-8.x - Build # 3453 - Still Failing!
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.x/3453/
All tests passed
Build Log:
[...truncated 70768 lines...]
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:619: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:492: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:479: Source checkout is dirty (unversioned/missing files) after running tests!!! Offending files:
* solr/licenses/annotations-2.17.63.jar.sha1
Total time: 73 minutes 37 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
[Checks API] No suitable checks publisher found.
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
[JENKINS] Lucene » Lucene-Solr-Tests-8.x - Build # 3452 - Still Failing!
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.x/3452/
All tests passed
Build Log:
[...truncated 70798 lines...]
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:619: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:492: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:479: Source checkout is dirty (unversioned/missing files) after running tests!!! Offending files:
* solr/licenses/annotations-2.17.63.jar.sha1
Total time: 76 minutes 34 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
[Checks API] No suitable checks publisher found.
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
[JENKINS] Lucene » Lucene-Solr-Tests-8.x - Build # 3451 - Still Failing!
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.x/3451/
All tests passed
Build Log:
[...truncated 70751 lines...]
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:619: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:492: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:479: Source checkout is dirty (unversioned/missing files) after running tests!!! Offending files:
* solr/licenses/annotations-2.17.63.jar.sha1
Total time: 74 minutes 4 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
[Checks API] No suitable checks publisher found.
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any