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

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

Error Message:
Error from server at http://127.0.0.1:34043/collection1: 
org.apache.solr.client.solrj.SolrServerException: Time allowed to handle this 
request exceeded:[http://[::1]:8]

Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:34043/collection1: 
org.apache.solr.client.solrj.SolrServerException: Time allowed to handle this 
request exceeded:[http://[::1]:8]
        at 
__randomizedtesting.SeedInfo.seed([46646B2117C3F445:CE3054FBB93F99BD]:0)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:681)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:266)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:214)
        at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1003)
        at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1018)
        at 
org.apache.solr.BaseDistributedSearchTestCase.queryServer(BaseDistributedSearchTestCase.java:623)
        at 
org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest.queryAllowPartialResults(DistributedQueryComponentCustomSortTest.java:139)
        at 
org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest.test(DistributedQueryComponentCustomSortTest.java:129)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1084)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1055)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at org.junit.rules.RunRules.evaluate(RunRules.java:20)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at org.junit.rules.RunRules.evaluate(RunRules.java:20)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at org.junit.rules.RunRules.evaluate(RunRules.java:20)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at org.junit.rules.RunRules.evaluate(RunRules.java:20)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)


FAILED:  org.apache.solr.client.solrj.impl.Http2SolrClientTest.testUpdate

Error Message:
Captured an uncaught exception in thread: Thread[id=6071, 
name=h2sc-3382-thread-12, state=RUNNABLE, group=TGRP-Http2SolrClientTest]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=6071, name=h2sc-3382-thread-12, state=RUNNABLE, 
group=TGRP-Http2SolrClientTest]
        at 
__randomizedtesting.SeedInfo.seed([1E367FF75D6EDCF8:A8203AFD3BAA342E]:0)
Caused by: java.util.concurrent.RejectedExecutionException: Task 
java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask@553545be 
rejected from 
java.util.concurrent.ScheduledThreadPoolExecutor@5bf2a168[Terminated, pool size 
= 0, active threads = 0, queued tasks = 0, completed tasks = 0]
        at __randomizedtesting.SeedInfo.seed([1E367FF75D6EDCF8]:0)
        at 
java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2063)
        at 
java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:830)
        at 
java.util.concurrent.ScheduledThreadPoolExecutor.delayedExecute(ScheduledThreadPoolExecutor.java:326)
        at 
java.util.concurrent.ScheduledThreadPoolExecutor.schedule(ScheduledThreadPoolExecutor.java:533)
        at 
org.eclipse.jetty.util.thread.ScheduledExecutorScheduler.schedule(ScheduledExecutorScheduler.java:125)
        at 
org.eclipse.jetty.util.SocketAddressResolver$Async.lambda$resolve$1(SocketAddressResolver.java:157)
        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:218)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 15680 lines...]
   [junit4] Suite: 
org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest
   [junit4]   2> 1996348 INFO  
(SUITE-DistributedQueryComponentCustomSortTest-seed#[46646B2117C3F445]-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> 1996348 INFO  
(SUITE-DistributedQueryComponentCustomSortTest-seed#[46646B2117C3F445]-worker) 
[     ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 1996349 INFO  
(SUITE-DistributedQueryComponentCustomSortTest-seed#[46646B2117C3F445]-worker) 
[     ] o.a.s.u.ErrorLogMuter Closing ErrorLogMuter-regex-360 after mutting 0 
log messages
   [junit4]   2> 1996349 INFO  
(SUITE-DistributedQueryComponentCustomSortTest-seed#[46646B2117C3F445]-worker) 
[     ] o.a.s.u.ErrorLogMuter Creating ErrorLogMuter-regex-361 for ERROR logs 
matching regex: ignore_exception
   [junit4]   2> 1996350 INFO  
(SUITE-DistributedQueryComponentCustomSortTest-seed#[46646B2117C3F445]-worker) 
[     ] o.a.s.SolrTestCaseJ4 Created dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_46646B2117C3F445-001/data-dir-168-001
   [junit4]   2> 1996350 WARN  
(SUITE-DistributedQueryComponentCustomSortTest-seed#[46646B2117C3F445]-worker) 
[     ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
   [junit4]   2> 1996350 INFO  
(SUITE-DistributedQueryComponentCustomSortTest-seed#[46646B2117C3F445]-worker) 
[     ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 1996352 INFO  
(SUITE-DistributedQueryComponentCustomSortTest-seed#[46646B2117C3F445]-worker) 
[     ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 1996352 INFO  
(SUITE-DistributedQueryComponentCustomSortTest-seed#[46646B2117C3F445]-worker) 
[     ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system 
property: /
   [junit4]   2> 1996353 INFO  
(SUITE-DistributedQueryComponentCustomSortTest-seed#[46646B2117C3F445]-worker) 
[     ] o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 1996366 INFO  
(SUITE-DistributedQueryComponentCustomSortTest-seed#[46646B2117C3F445]-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> 1996392 INFO  
(SUITE-DistributedQueryComponentCustomSortTest-seed#[46646B2117C3F445]-worker) 
[     ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
   [junit4]   2> 1996392 WARN  
(SUITE-DistributedQueryComponentCustomSortTest-seed#[46646B2117C3F445]-worker) 
[     ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently 
not implemented and has no effect.
   [junit4]   2> 1996392 WARN  
(SUITE-DistributedQueryComponentCustomSortTest-seed#[46646B2117C3F445]-worker) 
[     ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use 
solr.xml:/metrics/reporter section instead
   [junit4]   2> 1996393 INFO  
(SUITE-DistributedQueryComponentCustomSortTest-seed#[46646B2117C3F445]-worker) 
[     ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort
   [junit4]   2> 1996394 INFO  
(SUITE-DistributedQueryComponentCustomSortTest-seed#[46646B2117C3F445]-worker) 
[     ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 with 
uniqueid field id
   [junit4]   2> 1997497 WARN  
(SUITE-DistributedQueryComponentCustomSortTest-seed#[46646B2117C3F445]-worker) 
[     ] o.a.s.c.CoreContainer Unable to create 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/userfiles].
  Features requiring this directory may fail.
   [junit4]   2>           => java.security.AccessControlException: access 
denied ("java.io.FilePermission" 
"/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/userfiles"
 "write")
   [junit4]   2>        at 
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
   [junit4]   2> java.security.AccessControlException: access denied 
("java.io.FilePermission" 
"/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/userfiles"
 "write")
   [junit4]   2>        at 
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
 ~[?:1.8.0_291]
   [junit4]   2>        at 
java.security.AccessController.checkPermission(AccessController.java:886) 
~[?:1.8.0_291]
   [junit4]   2>        at 
java.lang.SecurityManager.checkPermission(SecurityManager.java:549) 
~[?:1.8.0_291]
   [junit4]   2>        at 
java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_291]
   [junit4]   2>        at sun.nio.fs.UnixPath.checkWrite(UnixPath.java:801) 
~[?:?]
   [junit4]   2>        at 
sun.nio.fs.UnixFileSystemProvider.createDirectory(UnixFileSystemProvider.java:376)
 ~[?:?]
   [junit4]   2>        at java.nio.file.Files.createDirectory(Files.java:674) 
~[?:1.8.0_291]
   [junit4]   2>        at 
java.nio.file.Files.createAndCheckIsDirectory(Files.java:781) ~[?:1.8.0_291]
   [junit4]   2>        at 
java.nio.file.Files.createDirectories(Files.java:727) ~[?:1.8.0_291]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:378) [java/:?]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:343) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:183) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:156) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:162) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:830) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:820) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:667) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:656) [java/:?]
   [junit4]   2>        at 
org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest.setUpBeforeClass(DistributedQueryComponentCustomSortTest.java:44)
 [test/:?]
   [junit4]   2>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method) ~[?:1.8.0_291]
   [junit4]   2>        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) 
~[?:1.8.0_291]
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
 ~[?:1.8.0_291]
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:498) 
~[?:1.8.0_291]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:878)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at org.junit.rules.RunRules.evaluate(RunRules.java:20) 
[junit-4.13.1.jar:4.13.1]
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
 [java/:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
 [java/:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
 [java/:?]
   [junit4]   2>        at org.junit.rules.RunRules.evaluate(RunRules.java:20) 
[junit-4.13.1.jar:4.13.1]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748) [?:1.8.0_291]
   [junit4]   2> 1997498 WARN  
(SUITE-DistributedQueryComponentCustomSortTest-seed#[46646B2117C3F445]-worker) 
[     ] o.a.s.f.DistribPackageStore Unable to create 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/filestore]
 directory in SOLR_HOME 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr].
  Features requiring this directory may fail.
   [junit4]   2>           => java.security.AccessControlException: access 
denied ("java.io.FilePermission" 
"/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/filestore"
 "write")
   [junit4]   2>        at 
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
   [junit4]   2> java.security.AccessControlException: access denied 
("java.io.FilePermission" 
"/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/filestore"
 "write")
   [junit4]   2>        at 
java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
 ~[?:1.8.0_291]
   [junit4]   2>        at 
java.security.AccessController.checkPermission(AccessController.java:886) 
~[?:1.8.0_291]
   [junit4]   2>        at 
java.lang.SecurityManager.checkPermission(SecurityManager.java:549) 
~[?:1.8.0_291]
   [junit4]   2>        at 
java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_291]
   [junit4]   2>        at java.io.File.mkdir(File.java:1348) ~[?:1.8.0_291]
   [junit4]   2>        at java.io.File.mkdirs(File.java:1380) ~[?:1.8.0_291]
   [junit4]   2>        at 
org.apache.solr.filestore.DistribPackageStore.ensurePackageStoreDir(DistribPackageStore.java:561)
 [java/:?]
   [junit4]   2>        at 
org.apache.solr.filestore.DistribPackageStore.<init>(DistribPackageStore.java:81)
 [java/:?]
   [junit4]   2>        at 
org.apache.solr.filestore.PackageStoreAPI.<init>(PackageStoreAPI.java:78) 
[java/:?]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.load(CoreContainer.java:679) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:184) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:156) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:162) [java/:?]
   [junit4]   2>        at 
org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:830) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:820) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:667) [java/:?]
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:656) [java/:?]
   [junit4]   2>        at 
org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest.setUpBeforeClass(DistributedQueryComponentCustomSortTest.java:44)
 [test/:?]
   [junit4]   2>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method) ~[?:1.8.0_291]
   [junit4]   2>        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) 
~[?:1.8.0_291]
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
 ~[?:1.8.0_291]
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:498) 
~[?:1.8.0_291]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:878)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at org.junit.rules.RunRules.evaluate(RunRules.java:20) 
[junit-4.13.1.jar:4.13.1]
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
 [java/:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
 [java/:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
 [java/:?]
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
 [java/:?]
   [junit4]   2>        at org.junit.rules.RunRules.evaluate(RunRules.java:20) 
[junit-4.13.1.jar:4.13.1]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
 [randomizedtesting-runner-2.7.2.jar:?]
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748) [?:1.8.0_291]
   [junit4]   2> 1997499 INFO  
(SUITE-DistributedQueryComponentCustomSortTest-seed#[46646B2117C3F445]-worker) 
[     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 1997500 WARN  
(SUITE-DistributedQueryComponentCustomSortTest-seed#[46646B2117C3F445]-worker) 
[     ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@cf17bb1[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1997500 WARN  
(SUITE-DistributedQueryComponentCustomSortTest-seed#[46646B2117C3F445]-worker) 
[     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured 
for Client@cf17bb1[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1997505 WARN  
(SUITE-DistributedQueryComponentCustomSortTest-seed#[46646B2117C3F445]-worker) 
[     ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@745e7b69[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1997505 WARN  
(SUITE-DistributedQueryComponentCustomSortTest-seed#[46646B2117C3F445]-worker) 
[     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured 
for Client@745e7b69[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1997507 WARN  
(SUITE-DistributedQueryComponentCustomSortTest-seed#[46646B2117C3F445]-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> 1997533 INFO  
(SUITE-DistributedQueryComponentCustomSortTest-seed#[46646B2117C3F445]-worker) 
[     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51d887d6
   [junit4]   2> 1997539 INFO  
(SUITE-DistributedQueryComponentCustomSortTest-seed#[46646B2117C3F445]-worker) 
[     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51d887d6
   [junit4]   2> 1997539 INFO  
(SUITE-DistributedQueryComponentCustomSortTest-seed#[46646B2117C3F445]-worker) 
[     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51d887d6
   [junit4]   2> 1997541 INFO  (coreLoadExecutor-20517-thread-1) [     ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 
2147483647 cores with initial capacity of 1024
   [junit4]   2> 1997548 INFO  (coreLoadExecutor-20517-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> 1997565 INFO  (coreLoadExecutor-20517-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
   [junit4]   2> 1997565 WARN  (coreLoadExecutor-20517-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is 
currently not implemented and has no effect.
   [junit4]   2> 1997565 WARN  (coreLoadExecutor-20517-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> 1997566 INFO  (coreLoadExecutor-20517-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort
   [junit4]   2> 1997567 INFO  (coreLoadExecutor-20517-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 
with uniqueid field id
   [junit4]   2> 1997567 INFO  (coreLoadExecutor-20517-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> 1997567 INFO  (coreLoadExecutor-20517-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@51d887d6
   [junit4]   2> 1997567 INFO  (coreLoadExecutor-20517-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/J0/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_46646B2117C3F445-001/data-dir-168-001/]
   [junit4]   2> 1997568 INFO  (coreLoadExecutor-20517-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@4aa014e
   [junit4]   2> 1997616 INFO  (coreLoadExecutor-20517-thread-1) [    
x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1997616 INFO  (coreLoadExecutor-20517-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 1997617 INFO  (coreLoadExecutor-20517-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1997617 INFO  (coreLoadExecutor-20517-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1997618 INFO  (coreLoadExecutor-20517-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=41, maxMergeAtOnceExplicit=33, maxMergedSegmentMB=44.5556640625, 
floorSegmentMB=2.0673828125, forceMergeDeletesPctAllowed=22.55415313921266, 
segmentsPerTier=45.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0, 
deletesPctAllowed=36.81178313611669
   [junit4]   2> 1997619 INFO  (coreLoadExecutor-20517-thread-1) [    
x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1997624 INFO  (coreLoadExecutor-20517-thread-1) [    
x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1997646 INFO  (coreLoadExecutor-20517-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 1997646 INFO  (coreLoadExecutor-20517-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1714692910285324288
   [junit4]   2> 1997648 INFO  
(searcherExecutor-20519-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1997648 INFO  
(searcherExecutor-20519-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1997648 INFO  
(searcherExecutor-20519-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1997648 INFO  
(searcherExecutor-20519-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 1997648 INFO  
(searcherExecutor-20519-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1997648 INFO  
(searcherExecutor-20519-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1997649 INFO  
(searcherExecutor-20519-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1997649 INFO  
(SUITE-DistributedQueryComponentCustomSortTest-seed#[46646B2117C3F445]-worker) 
[     ] o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 1997649 INFO  
(searcherExecutor-20519-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1997649 INFO  
(searcherExecutor-20519-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1997650 INFO  
(searcherExecutor-20519-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 1997655 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.u.ErrorLogMuter Closing ErrorLogMuter-regex-361 after mutting 0 log 
messages
   [junit4]   2> 1997655 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.u.ErrorLogMuter Creating ErrorLogMuter-regex-362 for ERROR logs 
matching regex: ignore_exception
   [junit4]   2> 1997760 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] 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/J0/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_46646B2117C3F445-001/tempDir-001/control/cores/collection1
   [junit4]   2> 1997761 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1997761 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 1997761 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.s.Server jetty-9.4.44.v20210927; built: 2021-09-27T23:02:44.612Z; 
git: 8da83308eeca865e495e53ef315a249d63ba9332; jvm 1.8.0_291-b10
   [junit4]   2> 1997763 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1997763 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1997763 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 1997763 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@78914613{/,null,AVAILABLE}
   [junit4]   2> 1997763 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.s.AbstractConnector Started ServerConnector@2f897f38{HTTP/1.1, 
(http/1.1, h2c)}{127.0.0.1:42015}
   [junit4]   2> 1997763 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.s.Server Started @1997802ms
   [junit4]   2> 1997763 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{schema=schema-custom-field.xml, solrconfig=solrconfig.xml, hostContext=/, 
hostPort=42015, 
coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_46646B2117C3F445-001/tempDir-001/control/cores}
   [junit4]   2> 1997763 ERROR 
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may 
be missing or incomplete.
   [junit4]   2> 1997763 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1997763 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? 
version 8.11.0
   [junit4]   2> 1997763 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 1997763 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
   [junit4]   2> 1997763 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2021-10-26T14:29:49.180Z
   [junit4]   2> 1997763 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] 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/J0/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_46646B2117C3F445-001/tempDir-001/control/solr.xml
   [junit4]   2> 1997766 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 1997766 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1997767 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@51d887d6, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1999389 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 1999390 WARN  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@78119426[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1999390 WARN  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@78119426[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1999393 WARN  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@271af3a4[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1999393 WARN  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@271af3a4[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1999394 WARN  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] 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> 1999545 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for 
max 4 cores with initial capacity of 4
   [junit4]   2> 1999545 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics 
history in memory.
   [junit4]   2> 1999575 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51d887d6
   [junit4]   2> 1999595 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51d887d6
   [junit4]   2> 1999595 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51d887d6
   [junit4]   2> 1999597 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] 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/J0/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_46646B2117C3F445-001/tempDir-001/control/cores
   [junit4]   2> 1999597 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1999612 INFO  (coreLoadExecutor-20537-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> 1999660 INFO  (coreLoadExecutor-20537-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
   [junit4]   2> 1999660 WARN  (coreLoadExecutor-20537-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is 
currently not implemented and has no effect.
   [junit4]   2> 1999660 WARN  (coreLoadExecutor-20537-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> 1999661 INFO  (coreLoadExecutor-20537-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort
   [junit4]   2> 1999662 INFO  (coreLoadExecutor-20537-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 
with uniqueid field id
   [junit4]   2> 1999662 INFO  (coreLoadExecutor-20537-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> 1999662 INFO  (coreLoadExecutor-20537-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@51d887d6
   [junit4]   2> 1999662 INFO  (coreLoadExecutor-20537-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/J0/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_46646B2117C3F445-001/tempDir-001/control/cores/collection1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_46646B2117C3F445-001/tempDir-001/control/cores/collection1/data/]
   [junit4]   2> 1999663 INFO  (coreLoadExecutor-20537-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@12df3758
   [junit4]   2> 1999934 INFO  (coreLoadExecutor-20537-thread-1) [    
x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1999934 INFO  (coreLoadExecutor-20537-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 1999935 INFO  (coreLoadExecutor-20537-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1999935 INFO  (coreLoadExecutor-20537-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1999936 INFO  (coreLoadExecutor-20537-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=41, maxMergeAtOnceExplicit=33, maxMergedSegmentMB=44.5556640625, 
floorSegmentMB=2.0673828125, forceMergeDeletesPctAllowed=22.55415313921266, 
segmentsPerTier=45.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0, 
deletesPctAllowed=36.81178313611669
   [junit4]   2> 1999937 INFO  (coreLoadExecutor-20537-thread-1) [    
x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1999946 INFO  (coreLoadExecutor-20537-thread-1) [    
x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1999998 INFO  (coreLoadExecutor-20537-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 1999999 INFO  (coreLoadExecutor-20537-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1714692912752623616
   [junit4]   2> 2000000 INFO  
(searcherExecutor-20539-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 2000001 INFO  
(searcherExecutor-20539-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 2000001 INFO  
(searcherExecutor-20539-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 2000001 INFO  
(searcherExecutor-20539-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 2000001 INFO  
(searcherExecutor-20539-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 2000001 INFO  
(searcherExecutor-20539-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 2000002 INFO  
(searcherExecutor-20539-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 2000002 INFO  
(searcherExecutor-20539-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 2000003 INFO  
(searcherExecutor-20539-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 2000005 INFO  
(searcherExecutor-20539-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2000195 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] 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/J0/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_46646B2117C3F445-001/tempDir-001/shard0/cores/collection1
   [junit4]   2> 2000217 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 2000217 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 2000217 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.s.Server jetty-9.4.44.v20210927; built: 2021-09-27T23:02:44.612Z; 
git: 8da83308eeca865e495e53ef315a249d63ba9332; jvm 1.8.0_291-b10
   [junit4]   2> 2000219 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 2000219 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 2000219 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 2000220 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@3b339590{/,null,AVAILABLE}
   [junit4]   2> 2000221 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.s.AbstractConnector Started ServerConnector@25f50955{HTTP/1.1, 
(http/1.1, h2c)}{127.0.0.1:41511}
   [junit4]   2> 2000221 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.s.Server Started @2000260ms
   [junit4]   2> 2000221 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{schema=schema-custom-field.xml, solrconfig=solrconfig.xml, hostContext=/, 
hostPort=41511, 
coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_46646B2117C3F445-001/tempDir-001/shard0/cores}
   [junit4]   2> 2000221 ERROR 
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may 
be missing or incomplete.
   [junit4]   2> 2000221 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 2000221 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? 
version 8.11.0
   [junit4]   2> 2000221 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 2000221 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
   [junit4]   2> 2000221 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2021-10-26T14:29:51.638Z
   [junit4]   2> 2000221 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] 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/J0/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_46646B2117C3F445-001/tempDir-001/shard0/solr.xml
   [junit4]   2> 2000224 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 2000224 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 2000226 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@51d887d6, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 2001221 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 2001222 WARN  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@ca1ee62[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2001222 WARN  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@ca1ee62[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2001224 WARN  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@3b57ad27[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2001224 WARN  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@3b57ad27[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2001226 WARN  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] 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> 2001253 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for 
max 4 cores with initial capacity of 4
   [junit4]   2> 2001253 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics 
history in memory.
   [junit4]   2> 2001272 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51d887d6
   [junit4]   2> 2001283 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51d887d6
   [junit4]   2> 2001283 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51d887d6
   [junit4]   2> 2001284 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] 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/J0/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_46646B2117C3F445-001/tempDir-001/shard0/cores
   [junit4]   2> 2001284 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 2001292 INFO  (coreLoadExecutor-20556-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> 2001309 INFO  (coreLoadExecutor-20556-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
   [junit4]   2> 2001309 WARN  (coreLoadExecutor-20556-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is 
currently not implemented and has no effect.
   [junit4]   2> 2001309 WARN  (coreLoadExecutor-20556-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> 2001310 INFO  (coreLoadExecutor-20556-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort
   [junit4]   2> 2001310 INFO  (coreLoadExecutor-20556-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 
with uniqueid field id
   [junit4]   2> 2001310 INFO  (coreLoadExecutor-20556-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> 2001311 INFO  (coreLoadExecutor-20556-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@51d887d6
   [junit4]   2> 2001311 INFO  (coreLoadExecutor-20556-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/J0/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_46646B2117C3F445-001/tempDir-001/shard0/cores/collection1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_46646B2117C3F445-001/tempDir-001/shard0/cores/collection1/data/]
   [junit4]   2> 2001312 INFO  (coreLoadExecutor-20556-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@783e80b2
   [junit4]   2> 2001365 INFO  (coreLoadExecutor-20556-thread-1) [    
x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2001365 INFO  (coreLoadExecutor-20556-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 2001365 INFO  (coreLoadExecutor-20556-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2001365 INFO  (coreLoadExecutor-20556-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2001366 INFO  (coreLoadExecutor-20556-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=41, maxMergeAtOnceExplicit=33, maxMergedSegmentMB=44.5556640625, 
floorSegmentMB=2.0673828125, forceMergeDeletesPctAllowed=22.55415313921266, 
segmentsPerTier=45.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0, 
deletesPctAllowed=36.81178313611669
   [junit4]   2> 2001367 INFO  (coreLoadExecutor-20556-thread-1) [    
x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 2001374 INFO  (coreLoadExecutor-20556-thread-1) [    
x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 2001395 INFO  (coreLoadExecutor-20556-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 2001395 INFO  (coreLoadExecutor-20556-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1714692914216435712
   [junit4]   2> 2001396 INFO  
(searcherExecutor-20558-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 2001396 INFO  
(searcherExecutor-20558-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 2001396 INFO  
(searcherExecutor-20558-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 2001396 INFO  
(searcherExecutor-20558-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 2001397 INFO  
(searcherExecutor-20558-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 2001397 INFO  
(searcherExecutor-20558-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 2001397 INFO  
(searcherExecutor-20558-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 2001397 INFO  
(searcherExecutor-20558-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 2001397 INFO  
(searcherExecutor-20558-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 2001399 INFO  
(searcherExecutor-20558-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2001503 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] 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/J0/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_46646B2117C3F445-001/tempDir-001/shard1/cores/collection1
   [junit4]   2> 2001503 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 2001503 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 2001503 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.s.Server jetty-9.4.44.v20210927; built: 2021-09-27T23:02:44.612Z; 
git: 8da83308eeca865e495e53ef315a249d63ba9332; jvm 1.8.0_291-b10
   [junit4]   2> 2001504 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 2001504 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 2001504 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 2001504 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@3a0c90b6{/,null,AVAILABLE}
   [junit4]   2> 2001505 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.s.AbstractConnector Started ServerConnector@6ea5f35b{HTTP/1.1, 
(http/1.1, h2c)}{127.0.0.1:34043}
   [junit4]   2> 2001505 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.s.Server Started @2001543ms
   [junit4]   2> 2001505 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{schema=schema-custom-field.xml, solrconfig=solrconfig.xml, hostContext=/, 
hostPort=34043, 
coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_46646B2117C3F445-001/tempDir-001/shard1/cores}
   [junit4]   2> 2001505 ERROR 
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may 
be missing or incomplete.
   [junit4]   2> 2001505 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 2001505 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? 
version 8.11.0
   [junit4]   2> 2001505 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 2001505 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
   [junit4]   2> 2001505 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2021-10-26T14:29:52.922Z
   [junit4]   2> 2001505 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] 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/J0/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_46646B2117C3F445-001/tempDir-001/shard1/solr.xml
   [junit4]   2> 2001507 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 2001507 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 2001509 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@51d887d6, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 2002059 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 2002060 WARN  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@70348f51[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2002060 WARN  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@70348f51[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2002069 WARN  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@35936410[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2002069 WARN  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@35936410[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2002071 WARN  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] 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> 2002087 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for 
max 4 cores with initial capacity of 4
   [junit4]   2> 2002087 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics 
history in memory.
   [junit4]   2> 2002120 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51d887d6
   [junit4]   2> 2002131 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51d887d6
   [junit4]   2> 2002131 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51d887d6
   [junit4]   2> 2002132 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] 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/J0/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_46646B2117C3F445-001/tempDir-001/shard1/cores
   [junit4]   2> 2002132 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 2002140 INFO  (coreLoadExecutor-20575-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> 2002166 INFO  (coreLoadExecutor-20575-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
   [junit4]   2> 2002166 WARN  (coreLoadExecutor-20575-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is 
currently not implemented and has no effect.
   [junit4]   2> 2002166 WARN  (coreLoadExecutor-20575-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> 2002167 INFO  (coreLoadExecutor-20575-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort
   [junit4]   2> 2002167 INFO  (coreLoadExecutor-20575-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 
with uniqueid field id
   [junit4]   2> 2002167 INFO  (coreLoadExecutor-20575-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> 2002168 INFO  (coreLoadExecutor-20575-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@51d887d6
   [junit4]   2> 2002168 INFO  (coreLoadExecutor-20575-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/J0/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_46646B2117C3F445-001/tempDir-001/shard1/cores/collection1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_46646B2117C3F445-001/tempDir-001/shard1/cores/collection1/data/]
   [junit4]   2> 2002169 INFO  (coreLoadExecutor-20575-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@52d73201
   [junit4]   2> 2002231 INFO  (coreLoadExecutor-20575-thread-1) [    
x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2002231 INFO  (coreLoadExecutor-20575-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 2002231 INFO  (coreLoadExecutor-20575-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2002231 INFO  (coreLoadExecutor-20575-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2002232 INFO  (coreLoadExecutor-20575-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=41, maxMergeAtOnceExplicit=33, maxMergedSegmentMB=44.5556640625, 
floorSegmentMB=2.0673828125, forceMergeDeletesPctAllowed=22.55415313921266, 
segmentsPerTier=45.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0, 
deletesPctAllowed=36.81178313611669
   [junit4]   2> 2002233 INFO  (coreLoadExecutor-20575-thread-1) [    
x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 2002242 INFO  (coreLoadExecutor-20575-thread-1) [    
x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 2002265 INFO  (coreLoadExecutor-20575-thread-1) [    
x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 2002265 INFO  (coreLoadExecutor-20575-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1714692915128696832
   [junit4]   2> 2002266 INFO  
(searcherExecutor-20577-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 2002267 INFO  
(searcherExecutor-20577-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 2002267 INFO  
(searcherExecutor-20577-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 2002267 INFO  
(searcherExecutor-20577-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 2002267 INFO  
(searcherExecutor-20577-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 2002267 INFO  
(searcherExecutor-20577-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 2002267 INFO  
(searcherExecutor-20577-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 2002267 INFO  
(searcherExecutor-20577-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 2002267 INFO  
(searcherExecutor-20577-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 2002269 INFO  
(searcherExecutor-20577-thread-1-processing-x:collection1) [    x:collection1 ] 
o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 2002380 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] 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/J0/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_46646B2117C3F445-001/tempDir-001/shard2/cores/collection1
   [junit4]   2> 2002381 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 2002381 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 2002381 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.s.Server jetty-9.4.44.v20210927; built: 2021-09-27T23:02:44.612Z; 
git: 8da83308eeca865e495e53ef315a249d63ba9332; jvm 1.8.0_291-b10
   [junit4]   2> 2002383 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 2002383 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 2002383 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 2002383 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@796b13cd{/,null,AVAILABLE}
   [junit4]   2> 2002383 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.s.AbstractConnector Started ServerConnector@1180e50a{HTTP/1.1, 
(http/1.1, h2c)}{127.0.0.1:45849}
   [junit4]   2> 2002383 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.s.Server Started @2002422ms
   [junit4]   2> 2002383 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{schema=schema-custom-field.xml, solrconfig=solrconfig.xml, hostContext=/, 
hostPort=45849, 
coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_46646B2117C3F445-001/tempDir-001/shard2/cores}
   [junit4]   2> 2002383 ERROR 
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may 
be missing or incomplete.
   [junit4]   2> 2002383 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 2002384 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? 
version 8.11.0
   [junit4]   2> 2002384 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 2002384 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
   [junit4]   2> 2002384 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2021-10-26T14:29:53.801Z
   [junit4]   2> 2002384 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] 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/J0/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_46646B2117C3F445-001/tempDir-001/shard2/solr.xml
   [junit4]   2> 2002386 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 2002386 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 2002387 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@51d887d6, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 2002683 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 2002890 WARN  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@4e8d719b[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2002890 WARN  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@4e8d719b[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2002953 WARN  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@52045bc6[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2002953 WARN  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@52045bc6[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 2002954 WARN  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] 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> 2002977 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for 
max 4 cores with initial capacity of 4
   [junit4]   2> 2002977 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics 
history in memory.
   [junit4]   2> 2003025 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51d887d6
   [junit4]   2> 2003036 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51d887d6
   [junit4]   2> 2003036 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@51d887d6
   [junit4]   2> 2003037 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] 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/J0/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_46646B2117C3F445-001/tempDir-001/shard2/cores
   [junit4]   2> 2003037 INFO  
(TEST-DistributedQueryComponentCustomSortTest.test-seed#[46646B2117C3F445]) [   
  ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 2003048 INFO  (coreLoadExecutor-20594-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> 2003065 INFO  (coreLoadExecutor-20594-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
   [junit4]   2> 2003065 WARN  (coreLoadExecutor-20594-thread-1) [    
x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is 
currently not implemented and has no effect.
   [junit4]   2> 2003065 WARN  (coreLoadExecutor-20594-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> 2003066 INFO  (coreLoadExecutor-20594-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort
   [junit4]   2> 2003067 INFO  (coreLoadExecutor-20594-thread-1) [    
x:collection1 ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 
with uniqueid field id
   [junit4]   2> 2003067 INFO  (coreLoadExecutor-20594-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> 2003067 INFO  (coreLoadExecutor-20594-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@51d887d6
   [junit4]   2> 2003067 INFO  (coreLoadExecutor-20594-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/J0/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_46646B2117C3F445-001/tempDir-001/shard2/cores/collection1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_46646B2117C3F445-001/tempDir-001/shard2/cores/collection1/data/]
   [junit4]   2> 2003068 INFO  (coreLoadExecutor-20594-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@79ea7d82
   [junit4]   2> 2003123 INFO  (coreLoadExecutor-20594-thread-1) [    
x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2003123 INFO  (coreLoadExecutor-20594-thread-1) [    
x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 2003124 INFO  (coreLoadExecutor-20594-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2003124 INFO  (coreLoadExecutor-20594-thread-1) [    
x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2003125 INFO  (coreLoadExecutor-20594-thread-1) [    
x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=41, maxMergeAtOnceExplicit=33, maxMergedSegmentMB=44.5556640625, 
floorSegmentMB=2.0673828125, forceMergeDeletesPctAllowed=22.55

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

26962 INFO  (coreCloseExecutor-3400-thread-1) [     ] o.a.s.u.LoggingInfoStream 
[BD][coreCloseExecutor-3400-thread-1]: waitApply: no deletes to apply
   [junit4]   2> 226963 INFO  (coreCloseExecutor-3400-thread-1) [     ] 
o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-3400-thread-1]: 
updateMergeThreads ioThrottle=true targetMBPerSec=10240.0 MB/sec
   [junit4]   2> 226963 INFO  (coreCloseExecutor-3400-thread-1) [     ] 
o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-3400-thread-1]: now merge
   [junit4]   2> 226963 INFO  (coreCloseExecutor-3400-thread-1) [     ] 
o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-3400-thread-1]:   
index(source): _0(8.11.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=1.8.0_291, java.vm.version=25.291-b10, 
lucene.version=8.11.0, os.arch=amd64, java.runtime.version=1.8.0_291-b10, 
source=flush, os.version=5.4.0-45-generic, 
timestamp=1635259289928}]:[attributes={Lucene87StoredFieldsFormat.mode=BEST_SPEED}]
 :id=5i9occcovfsyoc1wsmyzolwtw
   [junit4]   2> 226963 INFO  (coreCloseExecutor-3400-thread-1) [     ] 
o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-3400-thread-1]:   no more 
merges pending; now return
   [junit4]   2> 226963 INFO  (coreCloseExecutor-3400-thread-1) [     ] 
o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3400-thread-1]: waitForMerges
   [junit4]   2> 226963 INFO  (coreCloseExecutor-3400-thread-1) [     ] 
o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3400-thread-1]: waitForMerges 
done
   [junit4]   2> 226963 INFO  (coreCloseExecutor-3400-thread-1) [     ] 
o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3400-thread-1]: commit: start
   [junit4]   2> 226963 INFO  (coreCloseExecutor-3400-thread-1) [     ] 
o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3400-thread-1]: commit: enter 
lock
   [junit4]   2> 226963 INFO  (coreCloseExecutor-3400-thread-1) [     ] 
o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3400-thread-1]: commit: now 
prepare
   [junit4]   2> 226963 INFO  (coreCloseExecutor-3400-thread-1) [     ] 
o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3400-thread-1]: prepareCommit: 
flush
   [junit4]   2> 226963 INFO  (coreCloseExecutor-3400-thread-1) [     ] 
o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3400-thread-1]:   index before 
flush _0(8.11.0):C1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_291, java.vm.version=25.291-b10, lucene.version=8.11.0, 
os.arch=amd64, java.runtime.version=1.8.0_291-b10, source=flush, 
os.version=5.4.0-45-generic, 
timestamp=1635259289928}]:[attributes={Lucene87StoredFieldsFormat.mode=BEST_SPEED}]
 :id=5i9occcovfsyoc1wsmyzolwtw
   [junit4]   2> 226963 INFO  (coreCloseExecutor-3400-thread-1) [     ] 
o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-3400-thread-1]: startFullFlush
   [junit4]   2> 226963 INFO  (coreCloseExecutor-3400-thread-1) [     ] 
o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3400-thread-1]: now apply all 
deletes for all segments buffered updates bytesUsed=0 reader pool bytesUsed=0
   [junit4]   2> 226963 INFO  (coreCloseExecutor-3400-thread-1) [     ] 
o.a.s.u.LoggingInfoStream [BD][coreCloseExecutor-3400-thread-1]: waitApply: no 
deletes to apply
   [junit4]   2> 226963 INFO  (coreCloseExecutor-3400-thread-1) [     ] 
o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-3400-thread-1]: 
coreCloseExecutor-3400-thread-1 finishFullFlush success=true
   [junit4]   2> 226963 INFO  (coreCloseExecutor-3400-thread-1) [     ] 
o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3400-thread-1]: startCommit(): 
start
   [junit4]   2> 226963 INFO  (coreCloseExecutor-3400-thread-1) [     ] 
o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3400-thread-1]:   skip 
startCommit(): no changes pending
   [junit4]   2> 226963 INFO  (coreCloseExecutor-3400-thread-1) [     ] 
o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3400-thread-1]: commit: 
pendingCommit == null; skip
   [junit4]   2> 226963 INFO  (coreCloseExecutor-3400-thread-1) [     ] 
o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3400-thread-1]: commit: took 
0.1 msec
   [junit4]   2> 226963 INFO  (coreCloseExecutor-3400-thread-1) [     ] 
o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3400-thread-1]: commit: done
   [junit4]   2> 226963 INFO  (coreCloseExecutor-3400-thread-1) [     ] 
o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3400-thread-1]: rollback
   [junit4]   2> 226963 INFO  (coreCloseExecutor-3400-thread-1) [     ] 
o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3400-thread-1]: all running 
merges have aborted
   [junit4]   2> 226963 INFO  (coreCloseExecutor-3400-thread-1) [     ] 
o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3400-thread-1]: rollback: done 
finish merges
   [junit4]   2> 226963 INFO  (coreCloseExecutor-3400-thread-1) [     ] 
o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-3400-thread-1]: abort
   [junit4]   2> 226963 INFO  (coreCloseExecutor-3400-thread-1) [     ] 
o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-3400-thread-1]: done abort 
success=true
   [junit4]   2> 226963 INFO  (coreCloseExecutor-3400-thread-1) [     ] 
o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3400-thread-1]: rollback: 
infos=_0(8.11.0):C1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, 
java.version=1.8.0_291, java.vm.version=25.291-b10, lucene.version=8.11.0, 
os.arch=amd64, java.runtime.version=1.8.0_291-b10, source=flush, 
os.version=5.4.0-45-generic, 
timestamp=1635259289928}]:[attributes={Lucene87StoredFieldsFormat.mode=BEST_SPEED}]
 :id=5i9occcovfsyoc1wsmyzolwtw
   [junit4]   2> 226963 INFO  (coreCloseExecutor-3400-thread-1) [     ] 
o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-3400-thread-1]: now 
checkpoint "_0(8.11.0):C1:[diagnostics={os=Linux, java.vendor=Oracle 
Corporation, java.version=1.8.0_291, java.vm.version=25.291-b10, 
lucene.version=8.11.0, os.arch=amd64, java.runtime.version=1.8.0_291-b10, 
source=flush, os.version=5.4.0-45-generic, 
timestamp=1635259289928}]:[attributes={Lucene87StoredFieldsFormat.mode=BEST_SPEED}]
 :id=5i9occcovfsyoc1wsmyzolwtw" [1 segments ; isCommit = false]
   [junit4]   2> 226963 INFO  (coreCloseExecutor-3400-thread-1) [     ] 
o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-3400-thread-1]: 0 msec to 
checkpoint
   [junit4]   2> 226971 INFO  
(SUITE-Http2SolrClientTest-seed#[1E367FF75D6EDCF8]-worker) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node 
tag=null
   [junit4]   2> 226971 INFO  
(SUITE-Http2SolrClientTest-seed#[1E367FF75D6EDCF8]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@5de97336: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry 
solr.node/com.codahale.metrics.MetricRegistry@32b16992
   [junit4]   2> 226976 INFO  
(SUITE-Http2SolrClientTest-seed#[1E367FF75D6EDCF8]-worker) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm 
tag=null
   [junit4]   2> 226976 INFO  
(SUITE-Http2SolrClientTest-seed#[1E367FF75D6EDCF8]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@23cb5d0f: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry 
solr.jvm/com.codahale.metrics.MetricRegistry@37672fbd
   [junit4]   2> 226978 INFO  
(SUITE-Http2SolrClientTest-seed#[1E367FF75D6EDCF8]-worker) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty 
tag=null
   [junit4]   2> 226978 INFO  
(SUITE-Http2SolrClientTest-seed#[1E367FF75D6EDCF8]-worker) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@2aa1aaff: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty/com.codahale.metrics.MetricRegistry@4ce2655a
   [junit4]   2> 226981 INFO  
(SUITE-Http2SolrClientTest-seed#[1E367FF75D6EDCF8]-worker) [     ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@2798bc1c{SSL, (ssl, 
http/1.1)}{127.0.0.1:0}
   [junit4]   2> 226981 INFO  
(SUITE-Http2SolrClientTest-seed#[1E367FF75D6EDCF8]-worker) [     ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@335f0012{/solr,null,STOPPED}
   [junit4]   2> 226982 INFO  
(SUITE-Http2SolrClientTest-seed#[1E367FF75D6EDCF8]-worker) [     ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 229905 INFO  
(SUITE-Http2SolrClientTest-seed#[1E367FF75D6EDCF8]-worker) [     ] 
o.a.s.u.ErrorLogMuter Closing ErrorLogMuter-regex-34 after mutting 0 log 
messages
   [junit4]   2> 229905 INFO  
(SUITE-Http2SolrClientTest-seed#[1E367FF75D6EDCF8]-worker) [     ] 
o.a.s.u.ErrorLogMuter Creating ErrorLogMuter-regex-38 for ERROR logs matching 
regex: ignore_exception
   [junit4]   2> 229906 INFO  
(SUITE-Http2SolrClientTest-seed#[1E367FF75D6EDCF8]-worker) [     ] 
o.a.s.SolrTestCaseJ4 ------------------------------------------------------- 
Done waiting for tracked resources to be released
   [junit4]   2> NOTE: test params are: codec=Lucene87, 
sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=da-DK, 
timezone=America/Argentina/San_Juan
   [junit4]   2> NOTE: Linux 5.4.0-45-generic amd64/Oracle Corporation 
1.8.0_291 (64-bit)/cpus=4,threads=1,free=248022904,total=529006592
   [junit4]   2> NOTE: All tests run in this JVM: [CorrelationEvaluatorTest, 
SolrExampleStreamingHttp2Test, TestDocumentObjectBinder, TestSolrProperties, 
CloudSolrClientTest, NaturalLogEvaluatorTest, PerReplicaStatesRestartTest, 
AbsoluteValueEvaluatorTest, FieldValueEvaluatorTest, StreamExpressionTest, 
TestPolicy2, JdbcDriverTest, ClientUtilsTest, 
ConcurrentUpdateSolrClientBadInputTest, HttpSolrClientBuilderTest, 
TestCloudSolrClientConnections, NamedListTest, HyperbolicCosineEvaluatorTest, 
TermsResponseTest, TestJSONParser, DivideEvaluatorTest, 
TestDelegationTokenRequest, TestV1toV2ApiMapper, RegressionEvaluatorTest, 
TestPathTrie, TestHash, TermsFacetMapTest, Http2SolrClientCompatibilityTest, 
Http2SolrClientTest]
   [junit4] Completed [141/215 (1!)] on J0 in 6.51s, 17 tests, 1 error <<< 
FAILURES!

[...truncated 53328 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to