You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2021/08/15 11:51:29 UTC

[JENKINS] Lucene » Lucene-Solr-Tests-8.x - Build # 2996 - Still Unstable!

Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.x/2996/

1 tests failed.
FAILED:  org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest.test

Error Message:
Number of documents (1) is different from number of expected values (3

Stack Trace:
java.lang.AssertionError: Number of documents (1) is different from number of expected values (3
	at __randomizedtesting.SeedInfo.seed([3FEB147662B14FEE:B7BF2BACCC4D2216]:0)
	at org.junit.Assert.fail(Assert.java:89)
	at org.apache.solr.SolrTestCaseJ4.assertFieldValues(SolrTestCaseJ4.java:2184)
	at org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest.test(DistributedQueryComponentCustomSortTest.java:128)
	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 15807 lines...]
   [junit4] Suite: org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest
   [junit4]   2> 2084727 INFO  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/server/solr/configsets/_default/conf'
   [junit4]   2> 2084728 INFO  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_3FEB147662B14FEE-001/data-dir-165-001
   [junit4]   2> 2084728 WARN  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=4 numCloses=4
   [junit4]   2> 2084728 INFO  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 2084729 INFO  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 2084729 INFO  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 2084730 INFO  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /rc_/n
   [junit4]   2> 2084730 INFO  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 2084736 INFO  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 2084750 INFO  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.10.0
   [junit4]   2> 2084750 WARN  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
   [junit4]   2> 2084750 WARN  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead
   [junit4]   2> 2084751 INFO  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort
   [junit4]   2> 2084752 INFO  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 with uniqueid field id
   [junit4]   2> 2085566 WARN  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.c.CoreContainer Unable to create [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/userfiles].  Features requiring this directory may fail.
   [junit4]   2>           => java.security.AccessControlException: access denied ("java.io.FilePermission" "/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/userfiles" "write")
   [junit4]   2> 	at java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
   [junit4]   2> java.security.AccessControlException: access denied ("java.io.FilePermission" "/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/userfiles" "write")
   [junit4]   2> 	at java.security.AccessControlContext.checkPermission(AccessControlContext.java:472) ~[?:1.8.0_291]
   [junit4]   2> 	at java.security.AccessController.checkPermission(AccessController.java:886) ~[?:1.8.0_291]
   [junit4]   2> 	at java.lang.SecurityManager.checkPermission(SecurityManager.java:549) ~[?:1.8.0_291]
   [junit4]   2> 	at java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_291]
   [junit4]   2> 	at sun.nio.fs.UnixPath.checkWrite(UnixPath.java:801) ~[?:?]
   [junit4]   2> 	at sun.nio.fs.UnixFileSystemProvider.createDirectory(UnixFileSystemProvider.java:376) ~[?:?]
   [junit4]   2> 	at java.nio.file.Files.createDirectory(Files.java:674) ~[?:1.8.0_291]
   [junit4]   2> 	at java.nio.file.Files.createAndCheckIsDirectory(Files.java:781) ~[?:1.8.0_291]
   [junit4]   2> 	at java.nio.file.Files.createDirectories(Files.java:727) ~[?:1.8.0_291]
   [junit4]   2> 	at org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:378) [java/:?]
   [junit4]   2> 	at org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:343) [java/:?]
   [junit4]   2> 	at org.apache.solr.util.TestHarness.<init>(TestHarness.java:183) [java/:?]
   [junit4]   2> 	at org.apache.solr.util.TestHarness.<init>(TestHarness.java:156) [java/:?]
   [junit4]   2> 	at org.apache.solr.util.TestHarness.<init>(TestHarness.java:162) [java/:?]
   [junit4]   2> 	at org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
   [junit4]   2> 	at org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:812) [java/:?]
   [junit4]   2> 	at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:802) [java/:?]
   [junit4]   2> 	at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:663) [java/:?]
   [junit4]   2> 	at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:652) [java/:?]
   [junit4]   2> 	at org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest.setUpBeforeClass(DistributedQueryComponentCustomSortTest.java:41) [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> 2085567 WARN  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.f.DistribPackageStore Unable to create [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/filestore] directory in SOLR_HOME [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr].  Features requiring this directory may fail.
   [junit4]   2>           => java.security.AccessControlException: access denied ("java.io.FilePermission" "/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/filestore" "write")
   [junit4]   2> 	at java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
   [junit4]   2> java.security.AccessControlException: access denied ("java.io.FilePermission" "/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/filestore" "write")
   [junit4]   2> 	at java.security.AccessControlContext.checkPermission(AccessControlContext.java:472) ~[?:1.8.0_291]
   [junit4]   2> 	at java.security.AccessController.checkPermission(AccessController.java:886) ~[?:1.8.0_291]
   [junit4]   2> 	at java.lang.SecurityManager.checkPermission(SecurityManager.java:549) ~[?:1.8.0_291]
   [junit4]   2> 	at java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_291]
   [junit4]   2> 	at java.io.File.mkdir(File.java:1348) ~[?:1.8.0_291]
   [junit4]   2> 	at java.io.File.mkdirs(File.java:1380) ~[?:1.8.0_291]
   [junit4]   2> 	at org.apache.solr.filestore.DistribPackageStore.ensurePackageStoreDir(DistribPackageStore.java:561) [java/:?]
   [junit4]   2> 	at org.apache.solr.filestore.DistribPackageStore.<init>(DistribPackageStore.java:81) [java/:?]
   [junit4]   2> 	at org.apache.solr.filestore.PackageStoreAPI.<init>(PackageStoreAPI.java:78) [java/:?]
   [junit4]   2> 	at org.apache.solr.core.CoreContainer.load(CoreContainer.java:679) [java/:?]
   [junit4]   2> 	at org.apache.solr.util.TestHarness.<init>(TestHarness.java:184) [java/:?]
   [junit4]   2> 	at org.apache.solr.util.TestHarness.<init>(TestHarness.java:156) [java/:?]
   [junit4]   2> 	at org.apache.solr.util.TestHarness.<init>(TestHarness.java:162) [java/:?]
   [junit4]   2> 	at org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
   [junit4]   2> 	at org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:812) [java/:?]
   [junit4]   2> 	at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:802) [java/:?]
   [junit4]   2> 	at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:663) [java/:?]
   [junit4]   2> 	at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:652) [java/:?]
   [junit4]   2> 	at org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest.setUpBeforeClass(DistributedQueryComponentCustomSortTest.java:41) [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> 2085569 INFO  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 2085569 WARN  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@5ddb512b[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2085569 WARN  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@5ddb512b[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2085572 WARN  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@5544a2e9[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2085572 WARN  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@5544a2e9[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2085573 WARN  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-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> 2085598 INFO  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@52e5e513
   [junit4]   2> 2085604 INFO  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@52e5e513
   [junit4]   2> 2085605 INFO  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@52e5e513
   [junit4]   2> 2085606 INFO  (coreLoadExecutor-21216-thread-1) [     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 2147483647 cores with initial capacity of 1024
   [junit4]   2> 2085619 INFO  (coreLoadExecutor-21216-thread-1) [    x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 2085635 INFO  (coreLoadExecutor-21216-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.10.0
   [junit4]   2> 2085635 WARN  (coreLoadExecutor-21216-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
   [junit4]   2> 2085635 WARN  (coreLoadExecutor-21216-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> 2085636 INFO  (coreLoadExecutor-21216-thread-1) [    x:collection1 ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort
   [junit4]   2> 2085637 INFO  (coreLoadExecutor-21216-thread-1) [    x:collection1 ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 with uniqueid field id
   [junit4]   2> 2085637 INFO  (coreLoadExecutor-21216-thread-1) [    x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1, trusted=true
   [junit4]   2> 2085637 INFO  (coreLoadExecutor-21216-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@52e5e513
   [junit4]   2> 2085637 INFO  (coreLoadExecutor-21216-thread-1) [    x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_3FEB147662B14FEE-001/data-dir-165-001/]
   [junit4]   2> 2085638 INFO  (coreLoadExecutor-21216-thread-1) [    x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=48, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4638735152072154]
   [junit4]   2> 2085696 INFO  (coreLoadExecutor-21216-thread-1) [    x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2085696 INFO  (coreLoadExecutor-21216-thread-1) [    x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2085696 INFO  (coreLoadExecutor-21216-thread-1) [    x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2085696 INFO  (coreLoadExecutor-21216-thread-1) [    x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2085697 INFO  (coreLoadExecutor-21216-thread-1) [    x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=23, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
   [junit4]   2> 2085698 INFO  (coreLoadExecutor-21216-thread-1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 2085713 INFO  (coreLoadExecutor-21216-thread-1) [    x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 2085773 INFO  (coreLoadExecutor-21216-thread-1) [    x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 2085774 INFO  (coreLoadExecutor-21216-thread-1) [    x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1708158355410780160
   [junit4]   2> 2085775 INFO  (searcherExecutor-21218-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 2085777 INFO  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 2085780 INFO  (searcherExecutor-21218-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 2085780 INFO  (searcherExecutor-21218-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 2085780 INFO  (searcherExecutor-21218-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 2085780 INFO  (searcherExecutor-21218-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 2085780 INFO  (searcherExecutor-21218-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 2085780 INFO  (searcherExecutor-21218-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 2085780 INFO  (searcherExecutor-21218-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 2085780 INFO  (searcherExecutor-21218-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 2085782 INFO  (searcherExecutor-21218-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2086003 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_3FEB147662B14FEE-001/tempDir-001/control/cores/collection1
   [junit4]   2> 2086004 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 2086004 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 2086004 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
   [junit4]   2> 2086255 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 2086255 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 2086255 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 2086269 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6ad8a39f{/rc_/n,null,AVAILABLE}
   [junit4]   2> 2086269 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.s.AbstractConnector Started ServerConnector@2c5f6448{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:36355}
   [junit4]   2> 2086269 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.s.Server Started @2086298ms
   [junit4]   2> 2086269 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema-custom-field.xml, solrconfig=solrconfig.xml, hostContext=/rc_/n, hostPort=36355, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_3FEB147662B14FEE-001/tempDir-001/control/cores}
   [junit4]   2> 2086270 ERROR (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 2086270 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 2086270 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.10.0
   [junit4]   2> 2086270 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 2086270 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
   [junit4]   2> 2086270 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2021-08-15T11:25:52.406Z
   [junit4]   2> 2086270 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_3FEB147662B14FEE-001/tempDir-001/control/solr.xml
   [junit4]   2> 2086272 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 2086273 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 2086274 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@52e5e513, but no JMX reporters were configured - adding default JMX reporter.
   [junit4]   2> 2086702 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 2086703 WARN  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@11972007[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2086703 WARN  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@11972007[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2086706 WARN  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@6f6eaef1[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2086706 WARN  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@6f6eaef1[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2086707 WARN  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] 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> 2086718 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4
   [junit4]   2> 2086718 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 2086739 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@52e5e513
   [junit4]   2> 2086754 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@52e5e513
   [junit4]   2> 2086755 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@52e5e513
   [junit4]   2> 2086758 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_3FEB147662B14FEE-001/tempDir-001/control/cores
   [junit4]   2> 2086758 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 2086791 INFO  (coreLoadExecutor-21236-thread-1) [    x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 2086814 INFO  (coreLoadExecutor-21236-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.10.0
   [junit4]   2> 2087019 WARN  (coreLoadExecutor-21236-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
   [junit4]   2> 2087019 WARN  (coreLoadExecutor-21236-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> 2087021 INFO  (coreLoadExecutor-21236-thread-1) [    x:collection1 ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort
   [junit4]   2> 2087022 INFO  (coreLoadExecutor-21236-thread-1) [    x:collection1 ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 with uniqueid field id
   [junit4]   2> 2087022 INFO  (coreLoadExecutor-21236-thread-1) [    x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1, trusted=true
   [junit4]   2> 2087022 INFO  (coreLoadExecutor-21236-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@52e5e513
   [junit4]   2> 2087022 INFO  (coreLoadExecutor-21236-thread-1) [    x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_3FEB147662B14FEE-001/tempDir-001/control/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_3FEB147662B14FEE-001/tempDir-001/control/cores/collection1/data/]
   [junit4]   2> 2087024 INFO  (coreLoadExecutor-21236-thread-1) [    x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=48, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4638735152072154]
   [junit4]   2> 2087145 INFO  (coreLoadExecutor-21236-thread-1) [    x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2087145 INFO  (coreLoadExecutor-21236-thread-1) [    x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2087146 INFO  (coreLoadExecutor-21236-thread-1) [    x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2087146 INFO  (coreLoadExecutor-21236-thread-1) [    x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2087146 INFO  (coreLoadExecutor-21236-thread-1) [    x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=23, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
   [junit4]   2> 2087147 INFO  (coreLoadExecutor-21236-thread-1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 2087161 INFO  (coreLoadExecutor-21236-thread-1) [    x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 2087422 INFO  (coreLoadExecutor-21236-thread-1) [    x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 2087422 INFO  (coreLoadExecutor-21236-thread-1) [    x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1708158357138833408
   [junit4]   2> 2087423 INFO  (searcherExecutor-21238-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 2087423 INFO  (searcherExecutor-21238-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 2087423 INFO  (searcherExecutor-21238-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 2087423 INFO  (searcherExecutor-21238-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 2087424 INFO  (searcherExecutor-21238-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 2087424 INFO  (searcherExecutor-21238-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 2087424 INFO  (searcherExecutor-21238-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 2087424 INFO  (searcherExecutor-21238-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 2087424 INFO  (searcherExecutor-21238-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 2087426 INFO  (searcherExecutor-21238-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2088040 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_3FEB147662B14FEE-001/tempDir-001/shard0/cores/collection1
   [junit4]   2> 2088041 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 2088041 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 2088041 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
   [junit4]   2> 2088045 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 2088045 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 2088045 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 2088047 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7f5d07d{/rc_/n,null,AVAILABLE}
   [junit4]   2> 2088047 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.s.AbstractConnector Started ServerConnector@54b7879e{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42937}
   [junit4]   2> 2088047 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.s.Server Started @2088075ms
   [junit4]   2> 2088047 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema-custom-field.xml, solrconfig=solrconfig.xml, hostContext=/rc_/n, hostPort=42937, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_3FEB147662B14FEE-001/tempDir-001/shard0/cores}
   [junit4]   2> 2088047 ERROR (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 2088047 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 2088047 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.10.0
   [junit4]   2> 2088047 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 2088047 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
   [junit4]   2> 2088047 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2021-08-15T11:25:54.183Z
   [junit4]   2> 2088047 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_3FEB147662B14FEE-001/tempDir-001/shard0/solr.xml
   [junit4]   2> 2088050 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 2088050 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 2088051 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@52e5e513, but no JMX reporters were configured - adding default JMX reporter.
   [junit4]   2> 2089063 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 2089064 WARN  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@4b02d7a1[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2089064 WARN  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@4b02d7a1[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2089067 WARN  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@4c405b80[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2089067 WARN  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@4c405b80[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2089069 WARN  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] 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> 2089079 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4
   [junit4]   2> 2089079 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 2089099 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@52e5e513
   [junit4]   2> 2089110 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@52e5e513
   [junit4]   2> 2089110 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@52e5e513
   [junit4]   2> 2089111 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_3FEB147662B14FEE-001/tempDir-001/shard0/cores
   [junit4]   2> 2089111 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 2089224 INFO  (coreLoadExecutor-21255-thread-1) [    x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 2089241 INFO  (coreLoadExecutor-21255-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.10.0
   [junit4]   2> 2089241 WARN  (coreLoadExecutor-21255-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
   [junit4]   2> 2089241 WARN  (coreLoadExecutor-21255-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> 2089243 INFO  (coreLoadExecutor-21255-thread-1) [    x:collection1 ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort
   [junit4]   2> 2089243 INFO  (coreLoadExecutor-21255-thread-1) [    x:collection1 ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 with uniqueid field id
   [junit4]   2> 2089243 INFO  (coreLoadExecutor-21255-thread-1) [    x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1, trusted=true
   [junit4]   2> 2089243 INFO  (coreLoadExecutor-21255-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@52e5e513
   [junit4]   2> 2089243 INFO  (coreLoadExecutor-21255-thread-1) [    x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_3FEB147662B14FEE-001/tempDir-001/shard0/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_3FEB147662B14FEE-001/tempDir-001/shard0/cores/collection1/data/]
   [junit4]   2> 2089244 INFO  (coreLoadExecutor-21255-thread-1) [    x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=48, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4638735152072154]
   [junit4]   2> 2089456 INFO  (coreLoadExecutor-21255-thread-1) [    x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2089456 INFO  (coreLoadExecutor-21255-thread-1) [    x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2089457 INFO  (coreLoadExecutor-21255-thread-1) [    x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2089457 INFO  (coreLoadExecutor-21255-thread-1) [    x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2089458 INFO  (coreLoadExecutor-21255-thread-1) [    x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=23, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
   [junit4]   2> 2089459 INFO  (coreLoadExecutor-21255-thread-1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 2089485 INFO  (coreLoadExecutor-21255-thread-1) [    x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 2089599 INFO  (coreLoadExecutor-21255-thread-1) [    x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 2089599 INFO  (coreLoadExecutor-21255-thread-1) [    x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1708158359421583360
   [junit4]   2> 2089600 INFO  (searcherExecutor-21257-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 2089601 INFO  (searcherExecutor-21257-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 2089601 INFO  (searcherExecutor-21257-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 2089601 INFO  (searcherExecutor-21257-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 2089601 INFO  (searcherExecutor-21257-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 2089601 INFO  (searcherExecutor-21257-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 2089601 INFO  (searcherExecutor-21257-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 2089601 INFO  (searcherExecutor-21257-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 2089601 INFO  (searcherExecutor-21257-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 2089603 INFO  (searcherExecutor-21257-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2089712 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_3FEB147662B14FEE-001/tempDir-001/shard1/cores/collection1
   [junit4]   2> 2089713 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 2089713 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 2089713 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
   [junit4]   2> 2089719 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 2089719 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 2089720 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 2089720 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7c99b513{/rc_/n,null,AVAILABLE}
   [junit4]   2> 2089720 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.s.AbstractConnector Started ServerConnector@36e21b47{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:46815}
   [junit4]   2> 2089720 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.s.Server Started @2089749ms
   [junit4]   2> 2089720 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema-custom-field.xml, solrconfig=solrconfig.xml, hostContext=/rc_/n, hostPort=46815, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_3FEB147662B14FEE-001/tempDir-001/shard1/cores}
   [junit4]   2> 2089720 ERROR (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 2089720 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 2089720 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.10.0
   [junit4]   2> 2089720 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 2089720 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
   [junit4]   2> 2089720 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2021-08-15T11:25:55.856Z
   [junit4]   2> 2089720 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_3FEB147662B14FEE-001/tempDir-001/shard1/solr.xml
   [junit4]   2> 2089723 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 2089723 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 2089724 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@52e5e513, but no JMX reporters were configured - adding default JMX reporter.
   [junit4]   2> 2090446 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 2090460 WARN  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@8e4780e[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2090460 WARN  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@8e4780e[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2090689 WARN  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@256183b6[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2090689 WARN  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@256183b6[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2090691 WARN  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] 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> 2090702 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4
   [junit4]   2> 2090702 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 2090722 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@52e5e513
   [junit4]   2> 2090733 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@52e5e513
   [junit4]   2> 2090734 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@52e5e513
   [junit4]   2> 2090735 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_3FEB147662B14FEE-001/tempDir-001/shard1/cores
   [junit4]   2> 2090735 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 2090756 INFO  (coreLoadExecutor-21274-thread-1) [    x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 2090797 INFO  (coreLoadExecutor-21274-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.10.0
   [junit4]   2> 2090797 WARN  (coreLoadExecutor-21274-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
   [junit4]   2> 2090807 WARN  (coreLoadExecutor-21274-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> 2090809 INFO  (coreLoadExecutor-21274-thread-1) [    x:collection1 ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort
   [junit4]   2> 2090809 INFO  (coreLoadExecutor-21274-thread-1) [    x:collection1 ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 with uniqueid field id
   [junit4]   2> 2090809 INFO  (coreLoadExecutor-21274-thread-1) [    x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1, trusted=true
   [junit4]   2> 2090810 INFO  (coreLoadExecutor-21274-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@52e5e513
   [junit4]   2> 2090810 INFO  (coreLoadExecutor-21274-thread-1) [    x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_3FEB147662B14FEE-001/tempDir-001/shard1/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_3FEB147662B14FEE-001/tempDir-001/shard1/cores/collection1/data/]
   [junit4]   2> 2090823 INFO  (coreLoadExecutor-21274-thread-1) [    x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=48, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4638735152072154]
   [junit4]   2> 2090922 INFO  (coreLoadExecutor-21274-thread-1) [    x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2090922 INFO  (coreLoadExecutor-21274-thread-1) [    x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2090923 INFO  (coreLoadExecutor-21274-thread-1) [    x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2090923 INFO  (coreLoadExecutor-21274-thread-1) [    x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2090924 INFO  (coreLoadExecutor-21274-thread-1) [    x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=23, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
   [junit4]   2> 2090925 INFO  (coreLoadExecutor-21274-thread-1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 2090952 INFO  (coreLoadExecutor-21274-thread-1) [    x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 2091222 INFO  (coreLoadExecutor-21274-thread-1) [    x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 2091222 INFO  (coreLoadExecutor-21274-thread-1) [    x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1708158361123422208
   [junit4]   2> 2091223 INFO  (searcherExecutor-21276-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 2091224 INFO  (searcherExecutor-21276-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 2091224 INFO  (searcherExecutor-21276-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 2091224 INFO  (searcherExecutor-21276-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 2091224 INFO  (searcherExecutor-21276-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 2091224 INFO  (searcherExecutor-21276-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 2091224 INFO  (searcherExecutor-21276-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 2091224 INFO  (searcherExecutor-21276-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 2091224 INFO  (searcherExecutor-21276-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 2091226 INFO  (searcherExecutor-21276-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2091334 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_3FEB147662B14FEE-001/tempDir-001/shard2/cores/collection1
   [junit4]   2> 2091335 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 2091335 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 2091335 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
   [junit4]   2> 2091384 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 2091384 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 2091384 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 2091385 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3777ee2{/rc_/n,null,AVAILABLE}
   [junit4]   2> 2091385 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.s.AbstractConnector Started ServerConnector@1eb2ccea{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:34185}
   [junit4]   2> 2091385 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.s.Server Started @2091414ms
   [junit4]   2> 2091385 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema-custom-field.xml, solrconfig=solrconfig.xml, hostContext=/rc_/n, hostPort=34185, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_3FEB147662B14FEE-001/tempDir-001/shard2/cores}
   [junit4]   2> 2091385 ERROR (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 2091385 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 2091385 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.10.0
   [junit4]   2> 2091385 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 2091385 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
   [junit4]   2> 2091385 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2021-08-15T11:25:57.521Z
   [junit4]   2> 2091386 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_3FEB147662B14FEE-001/tempDir-001/shard2/solr.xml
   [junit4]   2> 2091388 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 2091388 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 2091389 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@52e5e513, but no JMX reporters were configured - adding default JMX reporter.
   [junit4]   2> 2091787 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 2091899 WARN  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@6a44def6[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2091899 WARN  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@6a44def6[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2091903 WARN  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@52ef92ba[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2091903 WARN  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@52ef92ba[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2091905 WARN  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] 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> 2091917 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4
   [junit4]   2> 2091917 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 2091941 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@52e5e513
   [junit4]   2> 2091953 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@52e5e513
   [junit4]   2> 2091953 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@52e5e513
   [junit4]   2> 2091955 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_3FEB147662B14FEE-001/tempDir-001/shard2/cores
   [junit4]   2> 2091955 INFO  (TEST-DistributedQueryComponentCustomSortTest.test-seed#[3FEB147662B14FEE]) [     ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 2091983 INFO  (coreLoadExecutor-21293-thread-1) [    x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 2092046 INFO  (coreLoadExecutor-21293-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.10.0
   [junit4]   2> 2092046 WARN  (coreLoadExecutor-21293-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
   [junit4]   2> 2092047 WARN  (coreLoadExecutor-21293-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> 2092048 INFO  (coreLoadExecutor-21293-thread-1) [    x:collection1 ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort
   [junit4]   2> 2092049 INFO  (coreLoadExecutor-21293-thread-1) [    x:collection1 ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 with uniqueid field id
   [junit4]   2> 2092049 INFO  (coreLoadExecutor-21293-thread-1) [    x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1, trusted=true
   [junit4]   2> 2092049 INFO  (coreLoadExecutor-21293-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@52e5e513
   [junit4]   2> 2092049 INFO  (coreLoadExecutor-21293-thread-1) [    x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_3FEB147662B14FEE-001/tempDir-001/shard2/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_3FEB147662B14FEE-001/tempDir-001/shard2/cores/collection1/data/]
   [junit4]   2> 2092050 INFO  (coreLoadExecutor-21293-thread-1) [    x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=48, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4638735152072154]
   [junit4]   2> 2092101 INFO  (coreLoadExecutor-21293-thread-1) [    x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2092101 INFO  (coreLoadExecutor-21293-thread-1) [    x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 2092102 INFO  (coreLoadExecutor-21293-thread-1) [    x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2092102 INFO  (coreLoadExecutor-21293-thread-1) [    x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2092103 INFO  (coreLoadExecutor-21293-thread-1) [    x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=23, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
   [junit4]   2> 2092104 INFO  (coreLoadExecutor-21293-thread-1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 2092183 INFO  (coreLoadExecutor-21293-thread-1) [    x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 2092270 INFO  (coreLoadExecutor-21293-thread-1) [    x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 2092270 INFO  (coreLoadExecutor-21293-thread-1) [    x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1708158362222329856
   [junit4]   2> 2092271 INFO  (searcherExecutor-21295-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 2092271 INFO  (searcherExecutor-21295-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 2092271 INFO  (searcherExecutor-21295-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 2092271 INFO  (searcherExecutor-21295-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 2092272 INFO  (searcherExecutor-21295-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 2092272 INFO  (searcherExecutor-21295-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 2092272 INFO  (searcherExecutor-21295-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 2092272 INFO  (searcherExecutor-21295-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 2092272 INFO  (searcherExecutor-21295-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 2092274 INFO  (searcherExecutor-21295-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.

[...truncated too long message...]

letContextHandler@3777ee2{/rc_/n,null,STOPPED}
   [junit4]   2> 2093236 INFO  (closeThreadPool-21303-thread-7) [     ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@7c99b513{/rc_/n,null,STOPPED}
   [junit4]   2> 2093236 INFO  (closeThreadPool-21303-thread-4) [     ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 2093236 INFO  (closeThreadPool-21303-thread-7) [     ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 2093236 INFO  (closeThreadPool-21303-thread-2) [     ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@6ad8a39f{/rc_/n,null,STOPPED}
   [junit4]   2> 2093236 INFO  (closeThreadPool-21303-thread-2) [     ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=DistributedQueryComponentCustomSortTest -Dtests.method=test -Dtests.seed=3FEB147662B14FEE -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=pl -Dtests.timezone=America/Yakutat -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] FAILURE 7.46s J3 | DistributedQueryComponentCustomSortTest.test <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: Number of documents (1) is different from number of expected values (3
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([3FEB147662B14FEE:B7BF2BACCC4D2216]:0)
   [junit4]    > 	at org.apache.solr.SolrTestCaseJ4.assertFieldValues(SolrTestCaseJ4.java:2184)
   [junit4]    > 	at org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest.test(DistributedQueryComponentCustomSortTest.java:128)
   [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> 2093242 INFO  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 2093242 INFO  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1149493680
   [junit4]   2> 2093242 INFO  (coreCloseExecutor-21321-thread-1) [     ] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@c625b32
   [junit4]   2> 2093242 INFO  (coreCloseExecutor-21321-thread-1) [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1 tag=SolrCore@c625b32
   [junit4]   2> 2093242 INFO  (coreCloseExecutor-21321-thread-1) [     ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2bee5b5c: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1/com.codahale.metrics.MetricRegistry@7431ae35
   [junit4]   2> 2093245 INFO  (coreCloseExecutor-21321-thread-1) [     ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED (unnecessary).
   [junit4]   2> 2093249 INFO  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
   [junit4]   2> 2093249 INFO  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@110ab7f6: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@1198e98c
   [junit4]   2> 2093250 INFO  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
   [junit4]   2> 2093250 INFO  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@541f850c: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@607ea287
   [junit4]   2> 2093250 INFO  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
   [junit4]   2> 2093250 INFO  (SUITE-DistributedQueryComponentCustomSortTest-seed#[3FEB147662B14FEE]-worker) [     ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@22abd5ae: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@5ddf4b89
   [junit4]   2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_3FEB147662B14FEE-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene87): {_root_=PostingsFormat(name=LuceneFixedGap), id=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), text=PostingsFormat(name=MockRandom), asdfasdf_field_should_match_catchall_dynamic_field_adsfasdf=PostingsFormat(name=LuceneFixedGap)}, docValues:{payload=DocValuesFormat(name=Lucene80)}, maxPointsInLeafNode=1363, maxMBSortInHeap=7.187217837516784, sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=pl, timezone=America/Yakutat
   [junit4]   2> NOTE: Linux 4.15.0-147-generic amd64/Oracle Corporation 1.8.0_291 (64-bit)/cpus=4,threads=1,free=246787696,total=525336576
   [junit4]   2> NOTE: All tests run in this JVM: [TestMergePolicyConfig, TestConfigSetsAPIExclusivity, TestSolrConfigHandler, TestGroupingSearch, AlternateDirectoryTest, SimplePostToolTest, SystemLogListenerTest, PeerSyncTest, BlockCacheTest, TestSizeLimitedDistributedMap, QueryResultKeyTest, IndexSizeTriggerMixedBoundsTest, HdfsBackupRepositoryIntegrationTest, TestRuleBasedAuthorizationWithKerberos, AddReplicaTest, TestDistributedGrouping, LegacyCloudClusterPropTest, TestExplainDocTransformer, TestCopyFieldCollectionResource, TestManagedResource, ForceLeaderWithTlogReplicasTest, TestPayloadCheckQParserPlugin, TestJsonRequest, SOLR749Test, TestRTimerTree, TestPKIAuthenticationPlugin, TestHashQParserPlugin, SolrIndexConfigTest, TestReload, UtilsToolTest, JSONWriterTest, TestFieldCacheReopen, TestFunctionQuery, TestSimpleQParserPlugin, RequiredFieldsTest, DataDrivenBlockJoinTest, DocValuesMissingTest, TestSurroundQueryParser, TestFieldCacheWithThreads, CachingDirectoryFactoryTest, CopyFieldTest, TestSnapshotCoreBackup, ChaosMonkeySafeLeaderTest, TestUniqueKeyFieldResource, TestHalfAndHalfDocValues, HdfsRecoveryZkTest, HdfsChaosMonkeyNothingIsSafeTest, TestUnInvertedFieldException, RankQParserPluginTest, MetricsHandlerTest, FieldAnalysisRequestHandlerTest, PreAnalyzedFieldManagedSchemaCloudTest, MinimalSchemaTest, CloudReplicaSourceTest, TlogReplayBufferedWhileIndexingTest, CurrencyRangeFacetCloudTest, JvmMetricsTest, TestInPlaceUpdatesRequiredField, CoreAdminCreateDiscoverTest, TestSolrCloudWithSecureImpersonation, TestInfoStreamLogging, SpellCheckComponentTest, FileUtilsTest, DirectSolrConnectionTest, ImplicitSnitchTest, TestOmitPositions, SecurityHeadersTest, TestDeleteCollectionOnDownNodes, TestFilteredDocIdSet, TestCustomDocTransformer, XmlInterpolationTest, TestCollectionsAPIViaSolrCloudCluster, TestReplicationHandler, BitVectorTest, ResponseBuilderTest, ExternalFileFieldSortTest, TestPrepRecovery, TestExportWriter, LeaderFailoverAfterPartitionTest, TestNonDefinedSimilarityFactory, TestRestoreCore, CoreMergeIndexesAdminHandlerTest, SegmentsInfoRequestHandlerTest, SolrXmlInZkTest, HdfsTlogReplayBufferedWhileIndexingTest, TestUpdate, TestXmlQParser, TestBooleanSimilarityFactory, ConnectionManagerTest, DistributedMLTComponentTest, BasicAuthIntegrationTest, TestAnalyzeInfixSuggestions, UpdateRequestProcessorFactoryTest, DistributedFacetPivotLongTailTest, SharedFSAutoReplicaFailoverTest, TestLeaderElectionZkExpiry, TestSolrCachePerf, CategoryRoutedAliasUpdateProcessorTest, TestFreeTextSuggestions, MissingSegmentRecoveryTest, TestSnapshotCloudManager, TestJsonFacetsWithNestedObjects, TestSystemIdResolver, ShardSplitTest, BasicDistributedZkTest, TestSchemaResource, DistributedSpellCheckComponentTest, RandomizedTaggerTest, SolrTestCaseJ4DeleteCoreTest, TestUtilizeNode, TestConfigOverlay, TestComplexPhraseQParserPlugin, TestRequestStatusCollectionAPI, SolrIndexSearcherTest, TestLRUCache, ManagedSchemaDiffTest, BlockJoinFacetSimpleTest, DeleteInactiveReplicaTest, DeleteShardTest, DistribDocExpirationUpdateProcessorTest, LeaderElectionContextKeyTest, MetricsHistoryIntegrationTest, MultiSolrCloudTestCaseTest, MultiThreadedOCPTest, PackageManagerCLITest, RecoveryZkTest, ReindexCollectionTest, TestCloudInspectUtil, TestCloudPhrasesIdentificationComponent, TestCloudPseudoReturnFields, TestCloudRecovery2, TestDistributedMap, TestDownShardTolerantSearch, TestPullReplicaErrorHandling, TestQueryingOnDownCollection, TestRebalanceLeaders, TestStressLiveNodes, ComputePlanActionTest, NodeMarkersRegistrationTest, ScheduledMaintenanceTriggerTest, ScheduledTriggerIntegrationTest, TestSimComputePlanAction, TestSimDistribStateManager, TestSimLargeCluster, CdcrWithNodesRestartsTest, HDFSCollectionsAPITest, ExitableDirectoryReaderTest, TestBackupRepositoryFactory, TestBadConfig, TestCorePropertiesReload, TestCustomStream, TestSolrXml, TestSolrCloudSnapshots, TestSQLHandler, XmlUpdateRequestHandlerTest, HealthCheckHandlerTest, TestApiFramework, TestCollectionAPIs, TestConfigsApi, ThreadDumpHandlerTest, ZookeeperReadAPITest, DebugComponentTest, DistributedDebugComponentTest, DistributedQueryComponentCustomSortTest]
   [junit4] Completed [708/945 (1!)] on J3 in 8.73s, 1 test, 1 failure <<< FAILURES!

[...truncated 53318 lines...]