Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-BadApples-Tests-8.x/438/
1 tests failed. FAILED: org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest.test Error Message: Error from server at http://127.0.0.1:36029/collection1: org.apache.solr.client.solrj.SolrServerException: Time allowed to handle this request exceeded:[http://[::1]:4, http://[::1]:8, http://[::1]:6] Stack Trace: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:36029/collection1: org.apache.solr.client.solrj.SolrServerException: Time allowed to handle this request exceeded:[http://[::1]:4, http://[::1]:8, http://[::1]:6] at __randomizedtesting.SeedInfo.seed([FC129EBE444815B4:7446A164EAB4784C]: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 15685 lines...] [junit4] Suite: org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest [junit4] 2> 2092606 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-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-BadApples-Tests-8.x/solr/server/solr/configsets/_default/conf' [junit4] 2> 2092606 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 2092606 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_FC129EBE444815B4-001/data-dir-171-001 [junit4] 2> 2092606 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=9 numCloses=9 [junit4] 2> 2092606 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true [junit4] 2> 2092610 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN) [junit4] 2> 2092610 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: / [junit4] 2> 2092610 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 2092620 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 2092642 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0 [junit4] 2> 2092643 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect. [junit4] 2> 2092643 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead [junit4] 2> 2092644 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort [junit4] 2> 2092645 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 with uniqueid field id [junit4] 2> 2095475 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.a.s.c.CoreContainer Unable to create [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-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-BadApples-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-BadApples-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:813) [java/:?] [junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:803) [java/:?] [junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:664) [java/:?] [junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:653) [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> 2095476 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.a.s.f.DistribPackageStore Unable to create [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/filestore] directory in SOLR_HOME [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-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-BadApples-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-BadApples-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:813) [java/:?] [junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:803) [java/:?] [junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:664) [java/:?] [junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:653) [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> 2095478 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false] [junit4] 2> 2095478 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@40de32d5[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2095478 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@40de32d5[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2095485 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@715fe83e[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2095485 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@715fe83e[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2095486 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-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> 2095512 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@28a68d56 [junit4] 2> 2095519 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@28a68d56 [junit4] 2> 2095519 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@28a68d56 [junit4] 2> 2095520 INFO (coreLoadExecutor-21475-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 2147483647 cores with initial capacity of 1024 [junit4] 2> 2095528 INFO (coreLoadExecutor-21475-thread-1) [ x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 2095544 INFO (coreLoadExecutor-21475-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0 [junit4] 2> 2095545 WARN (coreLoadExecutor-21475-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect. [junit4] 2> 2095545 WARN (coreLoadExecutor-21475-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> 2095546 INFO (coreLoadExecutor-21475-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort [junit4] 2> 2095547 INFO (coreLoadExecutor-21475-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 with uniqueid field id [junit4] 2> 2095547 INFO (coreLoadExecutor-21475-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 2095547 INFO (coreLoadExecutor-21475-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@28a68d56 [junit4] 2> 2095547 INFO (coreLoadExecutor-21475-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_FC129EBE444815B4-001/data-dir-171-001/] [junit4] 2> 2095548 INFO (coreLoadExecutor-21475-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=10, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 2095594 INFO (coreLoadExecutor-21475-thread-1) [ x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2095594 INFO (coreLoadExecutor-21475-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 2095595 INFO (coreLoadExecutor-21475-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2095595 INFO (coreLoadExecutor-21475-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2095596 INFO (coreLoadExecutor-21475-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=7, maxMergeAtOnceExplicit=3, maxMergedSegmentMB=17.2919921875, floorSegmentMB=1.146484375, forceMergeDeletesPctAllowed=11.85996169608067, segmentsPerTier=12.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, deletesPctAllowed=21.681106525884445 [junit4] 2> 2095597 INFO (coreLoadExecutor-21475-thread-1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 2095780 INFO (coreLoadExecutor-21475-thread-1) [ x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 2095808 INFO (coreLoadExecutor-21475-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms [junit4] 2> 2095808 INFO (coreLoadExecutor-21475-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1714404318753325056 [junit4] 2> 2095809 INFO (searcherExecutor-21477-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 2095809 INFO (searcherExecutor-21477-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 2095809 INFO (searcherExecutor-21477-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 2095809 INFO (searcherExecutor-21477-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 2095809 INFO (searcherExecutor-21477-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 2095810 INFO (searcherExecutor-21477-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 2095810 INFO (searcherExecutor-21477-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 2095810 INFO (searcherExecutor-21477-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 2095810 INFO (searcherExecutor-21477-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 2095811 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 2095811 INFO (searcherExecutor-21477-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms [junit4] 2> 2095929 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_FC129EBE444815B4-001/tempDir-001/control/cores/collection1 [junit4] 2> 2095930 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0) [junit4] 2> 2095930 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ... [junit4] 2> 2095930 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] 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> 2095931 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 2095931 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2095931 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 2095931 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@60ea33ab{/,null,AVAILABLE} [junit4] 2> 2095932 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@3eb64469{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:34951} [junit4] 2> 2095932 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.s.Server Started @2095963ms [junit4] 2> 2095932 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema-custom-field.xml, solrconfig=solrconfig.xml, hostContext=/, hostPort=34951, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_FC129EBE444815B4-001/tempDir-001/control/cores} [junit4] 2> 2095932 ERROR (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2095932 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 2095932 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.11.0 [junit4] 2> 2095932 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 2095932 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr [junit4] 2> 2095932 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-10-23T10:02:46.855Z [junit4] 2> 2095932 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_FC129EBE444815B4-001/tempDir-001/control/solr.xml [junit4] 2> 2095934 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 2095934 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 2095936 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@28a68d56, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 2096494 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false] [junit4] 2> 2096702 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@4bd64949[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2096702 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@4bd64949[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2096762 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@230a70fc[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2096762 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@230a70fc[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2096764 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] 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> 2096776 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4 [junit4] 2> 2096776 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 2096797 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@28a68d56 [junit4] 2> 2096806 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@28a68d56 [junit4] 2> 2096806 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@28a68d56 [junit4] 2> 2096807 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_FC129EBE444815B4-001/tempDir-001/control/cores [junit4] 2> 2096807 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 2096815 INFO (coreLoadExecutor-21495-thread-1) [ x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 2096832 INFO (coreLoadExecutor-21495-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0 [junit4] 2> 2096832 WARN (coreLoadExecutor-21495-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect. [junit4] 2> 2096832 WARN (coreLoadExecutor-21495-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> 2096833 INFO (coreLoadExecutor-21495-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort [junit4] 2> 2096834 INFO (coreLoadExecutor-21495-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 with uniqueid field id [junit4] 2> 2096834 INFO (coreLoadExecutor-21495-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 2096834 INFO (coreLoadExecutor-21495-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@28a68d56 [junit4] 2> 2096834 INFO (coreLoadExecutor-21495-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_FC129EBE444815B4-001/tempDir-001/control/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_FC129EBE444815B4-001/tempDir-001/control/cores/collection1/data/] [junit4] 2> 2096835 INFO (coreLoadExecutor-21495-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=10, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 2096890 INFO (coreLoadExecutor-21495-thread-1) [ x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2096890 INFO (coreLoadExecutor-21495-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 2096891 INFO (coreLoadExecutor-21495-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2096891 INFO (coreLoadExecutor-21495-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2096891 INFO (coreLoadExecutor-21495-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=7, maxMergeAtOnceExplicit=3, maxMergedSegmentMB=17.2919921875, floorSegmentMB=1.146484375, forceMergeDeletesPctAllowed=11.85996169608067, segmentsPerTier=12.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, deletesPctAllowed=21.681106525884445 [junit4] 2> 2096892 INFO (coreLoadExecutor-21495-thread-1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 2096898 INFO (coreLoadExecutor-21495-thread-1) [ x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 2096922 INFO (coreLoadExecutor-21495-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms [junit4] 2> 2096922 INFO (coreLoadExecutor-21495-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1714404319921438720 [junit4] 2> 2096923 INFO (searcherExecutor-21497-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 2096923 INFO (searcherExecutor-21497-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 2096923 INFO (searcherExecutor-21497-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 2096923 INFO (searcherExecutor-21497-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 2096924 INFO (searcherExecutor-21497-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 2096924 INFO (searcherExecutor-21497-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 2096924 INFO (searcherExecutor-21497-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 2096924 INFO (searcherExecutor-21497-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 2096924 INFO (searcherExecutor-21497-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 2096926 INFO (searcherExecutor-21497-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms [junit4] 2> 2097033 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_FC129EBE444815B4-001/tempDir-001/shard0/cores/collection1 [junit4] 2> 2097034 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0) [junit4] 2> 2097034 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ... [junit4] 2> 2097034 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] 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> 2097034 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 2097034 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2097035 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 2097035 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3cfac089{/,null,AVAILABLE} [junit4] 2> 2097037 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@25d024f2{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:40403} [junit4] 2> 2097037 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.s.Server Started @2097069ms [junit4] 2> 2097037 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema-custom-field.xml, solrconfig=solrconfig.xml, hostContext=/, hostPort=40403, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_FC129EBE444815B4-001/tempDir-001/shard0/cores} [junit4] 2> 2097037 ERROR (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2097038 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 2097038 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.11.0 [junit4] 2> 2097038 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 2097038 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr [junit4] 2> 2097038 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-10-23T10:02:47.961Z [junit4] 2> 2097038 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_FC129EBE444815B4-001/tempDir-001/shard0/solr.xml [junit4] 2> 2097041 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 2097041 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 2097042 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@28a68d56, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 2098943 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false] [junit4] 2> 2098944 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@6b0d82f8[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2098944 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@6b0d82f8[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2098947 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@742a8973[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2098947 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@742a8973[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2098948 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] 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> 2098960 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4 [junit4] 2> 2098960 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 2098980 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@28a68d56 [junit4] 2> 2098991 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@28a68d56 [junit4] 2> 2098991 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@28a68d56 [junit4] 2> 2098992 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_FC129EBE444815B4-001/tempDir-001/shard0/cores [junit4] 2> 2098992 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 2099002 INFO (coreLoadExecutor-21514-thread-1) [ x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 2099034 INFO (coreLoadExecutor-21514-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0 [junit4] 2> 2099034 WARN (coreLoadExecutor-21514-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect. [junit4] 2> 2099035 WARN (coreLoadExecutor-21514-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> 2099036 INFO (coreLoadExecutor-21514-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort [junit4] 2> 2099037 INFO (coreLoadExecutor-21514-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 with uniqueid field id [junit4] 2> 2099037 INFO (coreLoadExecutor-21514-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 2099037 INFO (coreLoadExecutor-21514-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@28a68d56 [junit4] 2> 2099037 INFO (coreLoadExecutor-21514-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_FC129EBE444815B4-001/tempDir-001/shard0/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_FC129EBE444815B4-001/tempDir-001/shard0/cores/collection1/data/] [junit4] 2> 2099038 INFO (coreLoadExecutor-21514-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=10, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 2099092 INFO (coreLoadExecutor-21514-thread-1) [ x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2099092 INFO (coreLoadExecutor-21514-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 2099093 INFO (coreLoadExecutor-21514-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2099093 INFO (coreLoadExecutor-21514-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2099094 INFO (coreLoadExecutor-21514-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=7, maxMergeAtOnceExplicit=3, maxMergedSegmentMB=17.2919921875, floorSegmentMB=1.146484375, forceMergeDeletesPctAllowed=11.85996169608067, segmentsPerTier=12.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, deletesPctAllowed=21.681106525884445 [junit4] 2> 2099095 INFO (coreLoadExecutor-21514-thread-1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 2099102 INFO (coreLoadExecutor-21514-thread-1) [ x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 2099125 INFO (coreLoadExecutor-21514-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms [junit4] 2> 2099126 INFO (coreLoadExecutor-21514-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1714404322232500224 [junit4] 2> 2099127 INFO (searcherExecutor-21516-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 2099127 INFO (searcherExecutor-21516-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 2099127 INFO (searcherExecutor-21516-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 2099127 INFO (searcherExecutor-21516-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 2099127 INFO (searcherExecutor-21516-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 2099127 INFO (searcherExecutor-21516-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 2099127 INFO (searcherExecutor-21516-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 2099128 INFO (searcherExecutor-21516-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 2099128 INFO (searcherExecutor-21516-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 2099130 INFO (searcherExecutor-21516-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms [junit4] 2> 2099242 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_FC129EBE444815B4-001/tempDir-001/shard1/cores/collection1 [junit4] 2> 2099243 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0) [junit4] 2> 2099243 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ... [junit4] 2> 2099243 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] 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> 2099247 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 2099247 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2099247 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 2099251 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6593507a{/,null,AVAILABLE} [junit4] 2> 2099252 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@745e919{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42049} [junit4] 2> 2099252 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.s.Server Started @2099283ms [junit4] 2> 2099252 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema-custom-field.xml, solrconfig=solrconfig.xml, hostContext=/, hostPort=42049, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_FC129EBE444815B4-001/tempDir-001/shard1/cores} [junit4] 2> 2099252 ERROR (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2099252 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 2099252 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.11.0 [junit4] 2> 2099252 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 2099252 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr [junit4] 2> 2099252 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-10-23T10:02:50.175Z [junit4] 2> 2099252 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_FC129EBE444815B4-001/tempDir-001/shard1/solr.xml [junit4] 2> 2099254 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 2099254 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 2099256 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@28a68d56, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 2100107 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false] [junit4] 2> 2100108 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@75157d17[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2100108 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@75157d17[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2100111 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@70eb0ea1[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2100111 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@70eb0ea1[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2100113 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] 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> 2100127 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4 [junit4] 2> 2100127 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 2100147 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@28a68d56 [junit4] 2> 2100158 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@28a68d56 [junit4] 2> 2100158 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@28a68d56 [junit4] 2> 2100159 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_FC129EBE444815B4-001/tempDir-001/shard1/cores [junit4] 2> 2100159 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 2100167 INFO (coreLoadExecutor-21533-thread-1) [ x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 2100186 INFO (coreLoadExecutor-21533-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0 [junit4] 2> 2100186 WARN (coreLoadExecutor-21533-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect. [junit4] 2> 2100187 WARN (coreLoadExecutor-21533-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> 2100188 INFO (coreLoadExecutor-21533-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort [junit4] 2> 2100188 INFO (coreLoadExecutor-21533-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 with uniqueid field id [junit4] 2> 2100188 INFO (coreLoadExecutor-21533-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 2100188 INFO (coreLoadExecutor-21533-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@28a68d56 [junit4] 2> 2100188 INFO (coreLoadExecutor-21533-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_FC129EBE444815B4-001/tempDir-001/shard1/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_FC129EBE444815B4-001/tempDir-001/shard1/cores/collection1/data/] [junit4] 2> 2100190 INFO (coreLoadExecutor-21533-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=10, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 2100571 INFO (coreLoadExecutor-21533-thread-1) [ x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2100571 INFO (coreLoadExecutor-21533-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 2100572 INFO (coreLoadExecutor-21533-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2100572 INFO (coreLoadExecutor-21533-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2100572 INFO (coreLoadExecutor-21533-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=7, maxMergeAtOnceExplicit=3, maxMergedSegmentMB=17.2919921875, floorSegmentMB=1.146484375, forceMergeDeletesPctAllowed=11.85996169608067, segmentsPerTier=12.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, deletesPctAllowed=21.681106525884445 [junit4] 2> 2100573 INFO (coreLoadExecutor-21533-thread-1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 2100582 INFO (coreLoadExecutor-21533-thread-1) [ x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 2100611 INFO (coreLoadExecutor-21533-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms [junit4] 2> 2100612 INFO (coreLoadExecutor-21533-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1714404323790684160 [junit4] 2> 2100613 INFO (searcherExecutor-21535-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 2100613 INFO (searcherExecutor-21535-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 2100613 INFO (searcherExecutor-21535-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 2100613 INFO (searcherExecutor-21535-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 2100613 INFO (searcherExecutor-21535-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 2100613 INFO (searcherExecutor-21535-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 2100613 INFO (searcherExecutor-21535-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 2100613 INFO (searcherExecutor-21535-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 2100614 INFO (searcherExecutor-21535-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 2100615 INFO (searcherExecutor-21535-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms [junit4] 2> 2101245 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_FC129EBE444815B4-001/tempDir-001/shard2/cores/collection1 [junit4] 2> 2101246 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0) [junit4] 2> 2101246 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ... [junit4] 2> 2101246 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] 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> 2101251 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 2101251 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2101251 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 2101252 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7504d7c2{/,null,AVAILABLE} [junit4] 2> 2101252 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5d983ce2{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:36029} [junit4] 2> 2101252 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.s.Server Started @2101283ms [junit4] 2> 2101252 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema-custom-field.xml, solrconfig=solrconfig.xml, hostContext=/, hostPort=36029, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_FC129EBE444815B4-001/tempDir-001/shard2/cores} [junit4] 2> 2101252 ERROR (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2101252 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 2101252 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.11.0 [junit4] 2> 2101252 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 2101252 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr [junit4] 2> 2101252 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-10-23T10:02:52.175Z [junit4] 2> 2101252 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_FC129EBE444815B4-001/tempDir-001/shard2/solr.xml [junit4] 2> 2101269 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 2101269 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 2101271 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@28a68d56, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 2102327 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false] [junit4] 2> 2102534 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@71f0c2fe[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2102534 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@71f0c2fe[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2102537 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@6cc7634a[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2102537 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@6cc7634a[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2102538 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] 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> 2102549 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4 [junit4] 2> 2102549 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 2102568 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@28a68d56 [junit4] 2> 2102579 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@28a68d56 [junit4] 2> 2102579 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@28a68d56 [junit4] 2> 2102581 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_FC129EBE444815B4-001/tempDir-001/shard2/cores [junit4] 2> 2102581 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[FC129EBE444815B4]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 2102609 INFO (coreLoadExecutor-21552-thread-1) [ x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 2102629 INFO (coreLoadExecutor-21552-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0 [junit4] 2> 2102629 WARN (coreLoadExecutor-21552-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect. [junit4] 2> 2102629 WARN (coreLoadExecutor-21552-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> 2102630 INFO (coreLoadExecutor-21552-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort [junit4] 2> 2102631 INFO (coreLoadExecutor-21552-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 with uniqueid field id [junit4] 2> 2102631 INFO (coreLoadExecutor-21552-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 2102631 INFO (coreLoadExecutor-21552-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@28a68d56 [junit4] 2> 2102631 INFO (coreLoadExecutor-21552-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_FC129EBE444815B4-001/tempDir-001/shard2/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_FC129EBE444815B4-001/tempDir-001/shard2/cores/collection1/data/] [junit4] 2> 2102632 INFO (coreLoadExecutor-21552-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=10, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 2102686 INFO (coreLoadExecutor-21552-thread-1) [ x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2102686 INFO (coreLoadExecutor-21552-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 2102687 INFO (coreLoadExecutor-21552-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2102687 INFO (coreLoadExecutor-21552-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2102689 INFO (coreLoadExecutor-21552-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=7, maxMergeAtOnceExplicit=3, maxMergedSegmentMB=17.2919921875, floorSegmentMB=1.146484375, forceMergeDeletesPctAllowed=11.85996169608067, segmentsPerTier=12.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, deletesPctAllowed=21.681106525884445 [junit4] 2> 2102691 INFO (coreLoadExecutor-21552-thread-1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 2102709 INFO (coreLoadExecutor-21552-thread-1) [ x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 2102732 INFO (coreLoadExecutor-21552-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms [junit4] 2> 2102732 INFO (coreLoadExecutor-21552-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1714404326013665280 [junit4] 2> 2102733 INFO (searcherExecutor-21554-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 2102734 INFO (searc [...truncated too long message...] #1: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:36029/collection1: org.apache.solr.client.solrj.SolrServerException: Time allowed to handle this request exceeded:[http://[::1]:4, http://[::1]:8, http://[::1]:6] [junit4] > at __randomizedtesting.SeedInfo.seed([FC129EBE444815B4:7446A164EAB4784C]: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> 2103744 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 2103744 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=2009380239 [junit4] 2> 2103745 INFO (coreCloseExecutor-21580-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@51c677e0 [junit4] 2> 2103745 INFO (coreCloseExecutor-21580-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1 tag=SolrCore@51c677e0 [junit4] 2> 2103745 INFO (coreCloseExecutor-21580-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6f090672: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1/com.codahale.metrics.MetricRegistry@7b3219e3 [junit4] 2> 2103748 INFO (coreCloseExecutor-21580-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED (unnecessary). [junit4] 2> 2103749 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null [junit4] 2> 2103749 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@34ca37cb: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@b0c2d33 [junit4] 2> 2103750 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null [junit4] 2> 2103750 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1f74360: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@70eae88 [junit4] 2> 2103750 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null [junit4] 2> 2103750 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[FC129EBE444815B4]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@bc3f9b3: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@132074c6 [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_FC129EBE444815B4-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene87): {_root_=Lucene84, id=Lucene84, text=PostingsFormat(name=MockRandom), asdfasdf_field_should_match_catchall_dynamic_field_adsfasdf=Lucene84}, docValues:{id_i=DocValuesFormat(name=Lucene80), _version_=DocValuesFormat(name=Lucene80), payload=DocValuesFormat(name=Lucene80)}, maxPointsInLeafNode=905, maxMBSortInHeap=5.712116602860666, sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=no, timezone=Europe/Simferopol [junit4] 2> NOTE: Linux 5.4.0-45-generic amd64/Oracle Corporation 1.8.0_291 (64-bit)/cpus=4,threads=1,free=272547592,total=525860864 [junit4] 2> NOTE: All tests run in this JVM: [PolyFieldTest, TestBulkSchemaConcurrent, HdfsSyncSliceTest, TestManagedSchemaThreadSafety, TestNRTOpen, TestDistributedSearch, TestQueryTypes, TestManagedSynonymGraphFilterFactory, TestChildDocTransformerHierarchy, TestUtils, DaemonStreamApiTest, TestEmbeddedSolrServerAdminHandler, ResponseHeaderTest, LocalFSCloudIncrementalBackupTest, TestLogWatcher, TestReplicationHandlerBackup, HdfsWriteToMultipleCollectionsTest, UpdateLogTest, TestFieldCache, AuthToolTest, TestSolr4Spatial2, ScriptEngineTest, SolrCloudReportersTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestFieldCacheVsDocValues, TestFieldCollectionResource, TestStressLucene, ProtectedTermFilterFactoryTest, TestNumericTerms64, TestContainerPlugin, TermVectorComponentDistributedTest, TestSolrCoreProperties, MultiDestinationAuditLoggerTest, AnalyticsQueryTest, TestComplexPhraseLeadingWildcard, TestDistributedMap, SplitByPrefixTest, SolrIndexSplitterTest, HdfsDirectoryTest, TestStreamBody, TestCollationFieldDocValues, ReplicationFactorTest, TestFieldSortValues, DocumentBuilderTest, TestSweetSpotSimilarityFactory, AssignTest, SolrCLIZkUtilsTest, ZookeeperStatusHandlerFailureTest, SuggesterWFSTTest, CollectionTooManyReplicasTest, SearchRateTriggerIntegrationTest, LargeFieldTest, TestLFUCache, TestConfigSetProperties, TestSchemaManager, XsltUpdateRequestHandlerTest, EnumFieldTest, DistanceUnitsTest, TestIndexingPerformance, TestSolrJ, RestoreTriggerStateTest, PackageManagerCLITest, TestValueSourceCache, OverseerSolrResponseUnsafeSerializationTest, TestSimTriggerIntegration, JWTAuthPluginIntegrationTest, ParsingFieldUpdateProcessorsTest, TestSimNodeAddedTrigger, TestPartialUpdateDeduplication, TriggerCooldownIntegrationTest, SampleTest, CoreAdminHandlerTest, BasicFunctionalityTest, TestUseDocValuesAsStored, TestMacros, QueryParsingTest, SolrCoreMetricManagerTest, DistributedSuggestComponentTest, ChaosMonkeyNothingIsSafeTest, TestPullReplicaErrorHandling, TestSolrCloudWithDelegationTokens, TestMultiValuedNumericRangeQuery, DateRangeFieldTest, RequestHandlersTest, TestSimExecutePlanAction, BinaryUpdateRequestHandlerTest, TestSearcherReuse, TestFacetMethods, TestSubQueryTransformerDistrib, TestDocSet, LeaderTragicEventTest, MetricsHistoryHandlerTest, TestSolrCLIRunExample, TestSolrDeletionPolicy2, HdfsAutoAddReplicasIntegrationTest, TestTolerantUpdateProcessorCloud, DistributedFacetPivotSmallAdvancedTest, TestMaxTokenLenTokenizer, ConcurrentDeleteAndCreateCollectionTest, SoftAutoCommitTest, RulesTest, ReindexCollectionTest, SparseHLLTest, TestLegacyField, TestMiniSolrCloudClusterSSL, TestConfLoadPerf, TestAddFieldRealTimeGet, CacheHeaderTest, TestCorePropertiesReload, HdfsBasicDistributedZk2Test, ShardRoutingTest, TestLocalFSCloudBackupRestore, CreateRoutedAliasTest, TestRecoveryHdfs, TestRangeQuery, ConcurrentCreateRoutedAliasTest, ConnectionManagerTest, CreateCollectionCleanupTest, DeleteReplicaTest, DistribJoinFromCollectionTest, DistributedQueueTest, DocValuesNotIndexedTest, ForceLeaderTest, ForceLeaderWithTlogReplicasTest, FullSolrCloudDistribCmdsTest, HttpPartitionOnCommitTest, LeaderElectionIntegrationTest, LeaderFailureAfterFreshStartTest, MetricsHistoryWithAuthIntegrationTest, MoveReplicaHDFSTest, MoveReplicaTest, OverriddenZkACLAndCredentialsProvidersTest, OverseerRolesTest, RecoveryZkTest, RoutingToNodesWithPropertiesTest, SystemCollectionCompatTest, TestCloudConsistency, TestLockTree, TestRandomFlRTGCloud, TestSkipOverseerOperations, TestZkChroot, VMParamsZkACLAndCredentialsProvidersTest, ZkCLITest, ZkSolrClientTest, AutoScalingHandlerTest, IndexSizeTriggerSizeEstimationTest, MetricTriggerIntegrationTest, NodeAddedTriggerTest, NodeMarkersRegistrationTest, CdcrWithNodesRestartsTest, HdfsNNFailoverTest, HdfsRecoveryZkTest, ZkStateReaderTest, ImplicitSnitchTest, BlobRepositoryCloudTest, ConfigureRecoveryStrategyTest, CoreSorterTest, DirectoryFactoriesTest, DirectoryFactoryTest, SolrCoreTest, TestImplicitCoreProperties, TestLazyCores, FieldAnalysisRequestHandlerTest, JsonLoaderTest, MoreLikeThisHandlerTest, TestBlobHandler, TestStressIncrementalBackup, V2StandaloneTest, CoreAdminCreateDiscoverTest, LukeRequestHandlerTest, StatsReloadRaceTest, DebugComponentTest, DistributedExpandComponentTest, DistributedFacetPivotLargeTest, DistributedQueryComponentCustomSortTest] [junit4] Completed [704/949 (1!)] on J1 in 11.40s, 1 test, 1 error <<< FAILURES! [...truncated 55113 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
