You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@solr.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2026/09/20 09:47:38 UTC

[JENKINS] Solr » Solr-Test-10.x - Build # 2539 - Unstable!

Build: https://ci-builds.apache.org/job/Solr/job/Solr-Test-10.x/2539/

1 tests failed.
FAILED:  org.apache.solr.cloud.RecoveryAfterSoftCommitTest.test

Error Message:
org.apache.solr.client.solrj.SolrServerException: IOException occurred when talking to server at: http://127.0.0.1:35389/solr/collection1_shard1_replica_n3/update

Stack Trace:
org.apache.solr.client.solrj.SolrServerException: IOException occurred when talking to server at: http://127.0.0.1:35389/solr/collection1_shard1_replica_n3/update
	at __randomizedtesting.SeedInfo.seed([4F6C29C0C601D938:C738161A68FDB4C0]:0)
	at org.apache.solr.client.solrj.jetty.HttpJettySolrClient.request(HttpJettySolrClient.java:515)
	at org.apache.solr.client.solrj.jetty.HttpJettySolrClient.lambda$requestWithBaseUrl$1(HttpJettySolrClient.java:543)
	at org.apache.solr.client.solrj.jetty.HttpJettySolrClient.requestWithBaseUrl(HttpJettySolrClient.java:562)
	at org.apache.solr.client.solrj.jetty.HttpJettySolrClient.requestWithBaseUrl(HttpJettySolrClient.java:543)
	at org.apache.solr.client.solrj.impl.LBSolrClient.doRequest(LBSolrClient.java:626)
	at org.apache.solr.client.solrj.impl.LBSolrClient.doRequest(LBSolrClient.java:614)
	at org.apache.solr.client.solrj.impl.LBSolrClient.doRequest(LBSolrClient.java:639)
	at org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:583)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1052)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:683)
	at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:605)
	at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:314)
	at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:167)
	at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:132)
	at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:148)
	at org.apache.solr.cloud.RecoveryAfterSoftCommitTest.test(RecoveryAfterSoftCommitTest.java:106)
	at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103)
	at java.base/java.lang.reflect.Method.invoke(Method.java:580)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1780)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:959)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:995)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:1009)
	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:80)
	at org.junit.rules.RunRules.evaluate(RunRules.java:20)
	at org.apache.lucene.tests.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:48)
	at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
	at org.apache.lucene.tests.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:45)
	at org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
	at org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
	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:390)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:843)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:490)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:968)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:853)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:904)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:915)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:80)
	at org.junit.rules.RunRules.evaluate(RunRules.java:20)
	at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.tests.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.tests.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
	at org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
	at org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
	at org.apache.lucene.tests.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.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:390)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:850)
	at java.base/java.lang.Thread.run(Thread.java:1583)
Caused by: org.eclipse.jetty.io.EofException: Broken pipe
	at org.eclipse.jetty.io.SocketChannelEndPoint.flush(SocketChannelEndPoint.java:118)
	at org.eclipse.jetty.io.WriteFlusher.flush(WriteFlusher.java:419)
	at org.eclipse.jetty.io.WriteFlusher.write(WriteFlusher.java:272)
	at org.eclipse.jetty.io.WriteFlusher.write(WriteFlusher.java:251)
	at org.eclipse.jetty.io.AbstractEndPoint.write(AbstractEndPoint.java:368)
	at org.eclipse.jetty.http2.internal.HTTP2Flusher.process(HTTP2Flusher.java:331)
	at org.eclipse.jetty.util.IteratingCallback.processing(IteratingCallback.java:253)
	at org.eclipse.jetty.util.IteratingCallback.iterate(IteratingCallback.java:232)
	at org.eclipse.jetty.http2.HTTP2Session.frame(HTTP2Session.java:956)
	at org.eclipse.jetty.http2.HTTP2Session.data(HTTP2Session.java:943)
	at org.eclipse.jetty.http2.HTTP2Stream.data(HTTP2Stream.java:158)
	at org.eclipse.jetty.http2.client.transport.internal.HttpSenderOverHTTP2.sendContent(HttpSenderOverHTTP2.java:172)
	at org.eclipse.jetty.client.transport.HttpSender$ContentSender.process(HttpSender.java:572)
	at org.eclipse.jetty.util.IteratingCallback.processing(IteratingCallback.java:253)
	at org.eclipse.jetty.util.IteratingCallback.succeeded(IteratingCallback.java:398)
	at org.eclipse.jetty.io.content.AsyncContent.runDemandCallback(AsyncContent.java:238)
	at org.eclipse.jetty.io.content.AsyncContent.invokeDemandCallback(AsyncContent.java:231)
	at org.eclipse.jetty.util.thread.SerializedInvoker$Link.run(SerializedInvoker.java:268)
	at org.eclipse.jetty.util.thread.SerializedInvoker.run(SerializedInvoker.java:168)
	at org.eclipse.jetty.io.content.AsyncContent.offer(AsyncContent.java:117)
	at org.eclipse.jetty.io.content.AsyncContent.write(AsyncContent.java:74)
	at org.eclipse.jetty.io.content.OutputStreamContentSource$AsyncOutputStream.write(OutputStreamContentSource.java:89)
	at org.apache.solr.common.util.FastOutputStream.flush(FastOutputStream.java:207)
	at org.apache.solr.common.util.FastOutputStream.flushBuffer(FastOutputStream.java:200)
	at org.apache.solr.common.util.JavaBinCodec.marshal(JavaBinCodec.java:174)
	at org.apache.solr.client.solrj.request.JavaBinUpdateRequestCodec.marshal(JavaBinUpdateRequestCodec.java:88)
	at org.apache.solr.client.solrj.request.JavaBinRequestWriter$1.write(JavaBinRequestWriter.java:42)
	at org.apache.solr.client.solrj.jetty.HttpJettySolrClient.sendRequest(HttpJettySolrClient.java:758)
	at org.apache.solr.client.solrj.jetty.HttpJettySolrClient.request(HttpJettySolrClient.java:481)
	... 61 more
Caused by: java.io.IOException: Broken pipe
	at java.base/sun.nio.ch.SocketDispatcher.writev0(Native Method)
	at java.base/sun.nio.ch.SocketDispatcher.writev(SocketDispatcher.java:70)
	at java.base/sun.nio.ch.IOUtil.write(IOUtil.java:227)
	at java.base/sun.nio.ch.IOUtil.write(IOUtil.java:158)
	at java.base/sun.nio.ch.SocketChannelImpl.write(SocketChannelImpl.java:574)
	at java.base/java.nio.channels.SocketChannel.write(SocketChannel.java:660)
	at org.eclipse.jetty.io.SocketChannelEndPoint.flush(SocketChannelEndPoint.java:112)
	... 89 more




Build Log:
[...truncated 11 lines...]
ERROR: Workspace has a .git repository, but it appears to be corrupt.
hudson.plugins.git.GitException: Command "git rev-parse --resolve-git-dir /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/.git" returned status code 128:
stdout: 
stderr: fatal: not a gitdir '/home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/.git'

	at PluginClassLoader for git-client//org.jenkinsci.plugins.gitclient.CliGitAPIImpl.launchCommandIn(CliGitAPIImpl.java:2848)
	at PluginClassLoader for git-client//org.jenkinsci.plugins.gitclient.CliGitAPIImpl.launchCommandIn(CliGitAPIImpl.java:2768)
	at PluginClassLoader for git-client//org.jenkinsci.plugins.gitclient.CliGitAPIImpl.launchCommandIn(CliGitAPIImpl.java:2763)
	at PluginClassLoader for git-client//org.jenkinsci.plugins.gitclient.CliGitAPIImpl.launchCommand(CliGitAPIImpl.java:2052)
	at PluginClassLoader for git-client//org.jenkinsci.plugins.gitclient.CliGitAPIImpl.launchCommand(CliGitAPIImpl.java:2064)
	at PluginClassLoader for git-client//org.jenkinsci.plugins.gitclient.CliGitAPIImpl.hasGitRepo(CliGitAPIImpl.java:404)
	at PluginClassLoader for git-client//hudson.plugins.git.GitAPI.hasGitRepo(GitAPI.java:281)
	at jdk.internal.reflect.GeneratedMethodAccessor34.invoke(Unknown Source)
	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.base/java.lang.reflect.Method.invoke(Method.java:569)
	at hudson.remoting.RemoteInvocationHandler$RPCRequest.perform(RemoteInvocationHandler.java:986)
	at hudson.remoting.RemoteInvocationHandler$RPCRequest.call(RemoteInvocationHandler.java:961)
	at hudson.remoting.RemoteInvocationHandler$RPCRequest.call(RemoteInvocationHandler.java:907)
	at hudson.remoting.UserRequest.perform(UserRequest.java:225)
	at hudson.remoting.UserRequest.perform(UserRequest.java:50)
	at hudson.remoting.Request$2.run(Request.java:391)
	at hudson.remoting.InterceptingExecutorService.lambda$wrap$0(InterceptingExecutorService.java:81)
	at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136)
	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
	at java.base/java.lang.Thread.run(Thread.java:840)
Cloning the remote Git repository
Cloning repository https://gitbox.apache.org/repos/asf/solr.git
 > git init /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x # timeout=10
Fetching upstream changes from https://gitbox.apache.org/repos/asf/solr.git
 > git --version # timeout=10
 > git --version # 'git version 2.43.0'
 > git fetch --tags --force --progress -- https://gitbox.apache.org/repos/asf/solr.git +refs/heads/*:refs/remotes/origin/* # timeout=10
 > git config remote.origin.url https://gitbox.apache.org/repos/asf/solr.git # timeout=10
 > git config --add remote.origin.fetch +refs/heads/*:refs/remotes/origin/* # timeout=10
Avoid second fetch
 > git rev-parse refs/remotes/origin/branch_10x^{commit} # timeout=10
Checking out Revision f9181508ba80fb1b66099adff24c7218e348274e (refs/remotes/origin/branch_10x)
 > git config core.sparsecheckout # timeout=10
 > git checkout -f f9181508ba80fb1b66099adff24c7218e348274e # timeout=10
 > git branch -a -v --no-abbrev # timeout=10
 > git checkout -b branch_10x f9181508ba80fb1b66099adff24c7218e348274e # timeout=10
Commit message: "SOLR-18442: Fix OpenTelemetry Observable gauge memory leak"
 > git rev-list --no-walk f9181508ba80fb1b66099adff24c7218e348274e # timeout=10
No emails were triggered.
provisioning config files...
copy managed file [gradle.properties] to file:/home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/gradle.properties
[Gradle] - Launching build.
[Solr-Test-10.x] $ /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/gradlew -Dtests.haltonfailure=false -Dtests.badapples=false --continue test
Downloading gradle-wrapper.jar from https://raw.githubusercontent.com/gradle/gradle/v8.10.2/gradle/wrapper/gradle-wrapper.jar
To honour the JVM settings for this build a single-use Daemon process will be forked. For more on this, please refer to https://docs.gradle.org/9.7.0/userguide/gradle_daemon.html#sec:disabling_the_daemon in the Gradle documentation.
Daemon will be stopped at the end of the build 

> Task :build-infra:compileJava
Note: /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/build-tools/build-infra/src/main/java/org/apache/lucene/gradle/Checksum.java uses or overrides a deprecated API.
Note: Recompile with -Xlint:deprecation for details.

> Task :build-infra:pluginDescriptors
> Task :build-infra:processResources
> Task :build-infra:classes
> Task :build-infra:jar
> Task :gitStatus
> Task :checkJdkInternalsExportedToGradle

> Task :solr:api:compileJava
Note: Some input files use or override a deprecated API.
Note: Recompile with -Xlint:deprecation for details.

> Task :solr:api:processResources NO-SOURCE
> Task :solr:api:classes
> Task :solr:api:jar

> Task :randomizationInfo
Running tests with randomization seed: tests.seed=4F6C29C0C601D938

> Task :solr:api:resolve
> Task :solr:api:processTestResources
> Task :solr:core:processResources
> Task :solr:solrj:processResources
> Task :solr:solrj-jetty:processResources NO-SOURCE
> Task :solr:solrj-streaming:processResources
> Task :solr:solrj-zookeeper:processResources NO-SOURCE
> Task :solr:test-framework:processResources
> Task :solr:benchmark:processResources
> Task :solr:benchmark:processTestResources
> Task :solr:core:processTestResources
> Task :solr:modules:analysis-extras:processResources NO-SOURCE
> Task :solr:cross-dc-manager:processResources NO-SOURCE
> Task :solr:cross-dc-manager:processTestResources
> Task :solr:modules:cross-dc:processResources NO-SOURCE
> Task :solr:modules:opentelemetry:processResources NO-SOURCE
> Task :solr:server:compileJava SKIPPED
> Task :solr:server:processResources NO-SOURCE
> Task :solr:server:classes UP-TO-DATE
> Task :solr:server:compileTestJava NO-SOURCE
> Task :solr:server:processTestResources NO-SOURCE
> Task :solr:server:testClasses UP-TO-DATE
> Task :solr:server:test NO-SOURCE
> Task :solr:server:wipeTaskTemp
> Task :solr:solr-ref-guide:compileJava NO-SOURCE
> Task :solr:solr-ref-guide:processResources NO-SOURCE
> Task :solr:solr-ref-guide:classes UP-TO-DATE
> Task :solr:solr-ref-guide:copySolrjTestResources
> Task :solr:solr-ref-guide:processTestResources NO-SOURCE
> Task :solr:modules:sql:processResources
> Task :solr:solrj:processTestResources
> Task :solr:solrj-jetty:processTestResources
> Task :solr:solrj-streaming:processTestResources
> Task :solr:solrj-zookeeper:processTestResources
> Task :solr:test-framework:processTestResources
> Task :solr:webapp:processResources NO-SOURCE
> Task :solr:webapp:processTestResources
> Task :solr:modules:analysis-extras:processTestResources
> Task :solr:modules:clustering:processResources NO-SOURCE
> Task :solr:modules:clustering:processTestResources
> Task :solr:modules:cross-dc:processTestResources
> Task :solr:modules:cuvs:processResources NO-SOURCE
> Task :solr:modules:cuvs:processTestResources
> Task :solr:modules:extraction:processResources
> Task :solr:modules:extraction:processTestResources
> Task :solr:modules:gcs-repository:processResources NO-SOURCE
> Task :solr:modules:gcs-repository:processTestResources
> Task :solr:modules:jwt-auth:processResources NO-SOURCE
> Task :solr:modules:jwt-auth:processTestResources
> Task :solr:modules:langid:processResources NO-SOURCE
> Task :solr:modules:langid:processTestResources
> Task :solr:modules:language-models:processResources NO-SOURCE
> Task :solr:modules:language-models:processTestResources
> Task :solr:modules:ltr:processResources NO-SOURCE
> Task :solr:modules:ltr:processTestResources
> Task :solr:modules:opentelemetry:processTestResources
> Task :solr:modules:s3-repository:processResources NO-SOURCE
> Task :solr:modules:s3-repository:processTestResources
> Task :solr:modules:scripting:processResources NO-SOURCE
> Task :solr:modules:scripting:processTestResources
> Task :solr:modules:sql:copySolrCoreTestResources
> Task :solr:modules:sql:processTestResources

> Task :solr:solrj:openApiGenerate
Cleaned up output directory /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/solrj/build/generated before code generation.
[openApiGenerate] Worker isolation: classloader (fast startup, but generator classes accumulate in Gradle daemon Metaspace - consider workerIsolation = "process" if you hit metaspace pressure)
File (reserved word) cannot be used as model name. Renamed to ModelFile
############################################################################################
# Thanks for using OpenAPI Generator.                                                      #
# We appreciate your support! Please consider donating to help us maintain this project.   #
# https://opencollective.com/openapi_generator/donate                                      #
############################################################################################
Successfully generated code to /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/solrj/build/generated

> Task :solr:solrj:generatedSpotlessHelper
> Task :solr:solrj:generatedSpotless

> Task :solr:solrj:compileJava
Note: Some input files use or override a deprecated API.
Note: Recompile with -Xlint:deprecation for details.

> Task :solr:solrj-jetty:compileJava
Note: /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/solrj-jetty/src/java/org/apache/solr/client/solrj/jetty/HttpJettySolrClient.java uses or overrides a deprecated API.
Note: Recompile with -Xlint:deprecation for details.

> Task :solr:solrj-streaming:compileJava
Note: Some input files use or override a deprecated API.
Note: Recompile with -Xlint:deprecation for details.

> Task :solr:solrj-zookeeper:compileJava
> Task :solr:core:compileJava
Note: Some input files use or override a deprecated API.
Note: Recompile with -Xlint:deprecation for details.

> Task :solr:test-framework:compileJava
Note: Some input files use or override a deprecated API.
Note: Recompile with -Xlint:deprecation for details.

> Task :solr:api:compileTestJava
> Task :solr:api:testClasses
> Task :solr:core:classes
> Task :solr:core:jar
> Task :solr:solrj:classes
> Task :solr:solrj:jar
> Task :solr:solrj-jetty:classes
> Task :solr:solrj-jetty:jar
> Task :solr:solrj-streaming:classes
> Task :solr:solrj-streaming:jar
> Task :solr:solrj-zookeeper:classes
> Task :solr:solrj-zookeeper:jar
> Task :solr:test-framework:classes
> Task :solr:test-framework:jar

> Task :solr:api:test
WARNING: Using incubator modules: jdk.incubator.vector
WARNING: Using incubator modules: jdk.incubator.vector
WARNING: A command line option has enabled the Security Manager
WARNING: The Security Manager is deprecated and will be removed in a future release
WARNING: A command line option has enabled the Security Manager
WARNING: The Security Manager is deprecated and will be removed in a future release
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
:solr:api:test (SUCCESS): 19 test(s)

> Task :solr:api:wipeTaskTemp
> Task :solr:benchmark:compileJava
> Task :solr:benchmark:classes
> Task :solr:benchmark:compileTestJava
> Task :solr:benchmark:testClasses

> Task :solr:benchmark:test
WARNING: Using incubator modules: jdk.incubator.vector
WARNING: Using incubator modules: jdk.incubator.vector
WARNING: Using incubator modules: jdk.incubator.vector
WARNING: A command line option has enabled the Security Manager
WARNING: The Security Manager is deprecated and will be removed in a future release
WARNING: A command line option has enabled the Security Manager
WARNING: The Security Manager is deprecated and will be removed in a future release
WARNING: A command line option has enabled the Security Manager
WARNING: The Security Manager is deprecated and will be removed in a future release
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
:solr:benchmark:test (SUCCESS): 10 test(s)

> Task :solr:benchmark:wipeTaskTemp
> Task :solr:core:compileTestJava
Note: Some input files use or override a deprecated API.
Note: Recompile with -Xlint:deprecation for details.

> Task :solr:core:testClasses

> Task :solr:modules:analysis-extras:compileJava
Note: /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/modules/analysis-extras/src/java/org/apache/solr/schema/ICUCollationField.java uses or overrides a deprecated API.
Note: Recompile with -Xlint:deprecation for details.

> Task :solr:modules:analysis-extras:classes
> Task :solr:modules:analysis-extras:jar

> Task :solr:core:test
WARNING: Using incubator modules: jdk.incubator.vector
WARNING: Using incubator modules: jdk.incubator.vector
WARNING: Using incubator modules: jdk.incubator.vector
WARNING: Using incubator modules: jdk.incubator.vector
WARNING: A command line option has enabled the Security Manager
WARNING: The Security Manager is deprecated and will be removed in a future release
WARNING: A command line option has enabled the Security Manager
WARNING: The Security Manager is deprecated and will be removed in a future release
WARNING: A command line option has enabled the Security Manager
WARNING: The Security Manager is deprecated and will be removed in a future release
WARNING: A command line option has enabled the Security Manager
WARNING: The Security Manager is deprecated and will be removed in a future release
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.

[63.000s][warning][jfr,system] Could not initialize JDK events. access denied ("java.lang.RuntimePermission" "accessClassInPackage.jdk.internal.event")

> Task :solr:core:test
WARNING: Test org.apache.solr.TestRandomFaceting wrote 24,205,502 bytes of output.

RecoveryAfterSoftCommitTest > test FAILED
    org.apache.solr.client.solrj.SolrServerException: IOException occurred when talking to server at: http://127.0.0.1:35389/solr/collection1_shard1_replica_n3/update
        at __randomizedtesting.SeedInfo.seed([4F6C29C0C601D938:C738161A68FDB4C0]:0)
        at app//org.apache.solr.client.solrj.jetty.HttpJettySolrClient.request(HttpJettySolrClient.java:515)
        at app//org.apache.solr.client.solrj.jetty.HttpJettySolrClient.lambda$requestWithBaseUrl$1(HttpJettySolrClient.java:543)
        at app//org.apache.solr.client.solrj.jetty.HttpJettySolrClient.requestWithBaseUrl(HttpJettySolrClient.java:562)
        at app//org.apache.solr.client.solrj.jetty.HttpJettySolrClient.requestWithBaseUrl(HttpJettySolrClient.java:543)
        at app//org.apache.solr.client.solrj.impl.LBSolrClient.doRequest(LBSolrClient.java:626)
        at app//org.apache.solr.client.solrj.impl.LBSolrClient.doRequest(LBSolrClient.java:614)
        at app//org.apache.solr.client.solrj.impl.LBSolrClient.doRequest(LBSolrClient.java:639)
        at app//org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:583)
        at app//org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1052)
        at app//org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:683)
        at app//org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:605)
        at app//org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:314)
        at app//org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:167)
        at app//org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:132)
        at app//org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:148)
        at app//org.apache.solr.cloud.RecoveryAfterSoftCommitTest.test(RecoveryAfterSoftCommitTest.java:106)
        at java.base@21.0.12.1/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103)
        at java.base@21.0.12.1/java.lang.reflect.Method.invoke(Method.java:580)
        at app//com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1780)
        at app//com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:959)
        at app//com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:995)
        at app//com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:1009)
        at app//org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1084)
        at app//org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1055)
        at app//com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:80)
        at app//org.junit.rules.RunRules.evaluate(RunRules.java:20)
        at app//org.apache.lucene.tests.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:48)
        at app//org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
        at app//org.apache.lucene.tests.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:45)
        at app//org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
        at app//org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
        at app//org.junit.rules.RunRules.evaluate(RunRules.java:20)
        at app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at app//com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:390)
        at app//com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:843)
        at app//com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:490)
        at app//com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:968)
        at app//com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:853)
        at app//com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:904)
        at app//com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:915)
        at app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at app//org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
        at app//com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:80)
        at app//org.junit.rules.RunRules.evaluate(RunRules.java:20)
        at app//org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
        at app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at app//org.apache.lucene.tests.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
        at app//com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at app//com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at app//org.apache.lucene.tests.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at app//org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
        at app//org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
        at app//org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
        at app//org.apache.lucene.tests.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:47)
        at app//org.junit.rules.RunRules.evaluate(RunRules.java:20)
        at app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at app//com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:390)
        at app//com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:850)
        at java.base@21.0.12.1/java.lang.Thread.run(Thread.java:1583)

        Caused by:
        org.eclipse.jetty.io.EofException: Broken pipe
            at app//org.eclipse.jetty.io.SocketChannelEndPoint.flush(SocketChannelEndPoint.java:118)
            at app//org.eclipse.jetty.io.WriteFlusher.flush(WriteFlusher.java:419)
            at app//org.eclipse.jetty.io.WriteFlusher.write(WriteFlusher.java:272)
            at app//org.eclipse.jetty.io.WriteFlusher.write(WriteFlusher.java:251)
            at app//org.eclipse.jetty.io.AbstractEndPoint.write(AbstractEndPoint.java:368)
            at app//org.eclipse.jetty.http2.internal.HTTP2Flusher.process(HTTP2Flusher.java:331)
            at app//org.eclipse.jetty.util.IteratingCallback.processing(IteratingCallback.java:253)
            at app//org.eclipse.jetty.util.IteratingCallback.iterate(IteratingCallback.java:232)
            at app//org.eclipse.jetty.http2.HTTP2Session.frame(HTTP2Session.java:956)
            at app//org.eclipse.jetty.http2.HTTP2Session.data(HTTP2Session.java:943)
            at app//org.eclipse.jetty.http2.HTTP2Stream.data(HTTP2Stream.java:158)
            at app//org.eclipse.jetty.http2.client.transport.internal.HttpSenderOverHTTP2.sendContent(HttpSenderOverHTTP2.java:172)
            at app//org.eclipse.jetty.client.transport.HttpSender$ContentSender.process(HttpSender.java:572)
            at app//org.eclipse.jetty.util.IteratingCallback.processing(IteratingCallback.java:253)
            at app//org.eclipse.jetty.util.IteratingCallback.succeeded(IteratingCallback.java:398)
            at app//org.eclipse.jetty.io.content.AsyncContent.runDemandCallback(AsyncContent.java:238)
            at app//org.eclipse.jetty.io.content.AsyncContent.invokeDemandCallback(AsyncContent.java:231)
            at app//org.eclipse.jetty.util.thread.SerializedInvoker$Link.run(SerializedInvoker.java:268)
            at app//org.eclipse.jetty.util.thread.SerializedInvoker.run(SerializedInvoker.java:168)
            at app//org.eclipse.jetty.io.content.AsyncContent.offer(AsyncContent.java:117)
            at app//org.eclipse.jetty.io.content.AsyncContent.write(AsyncContent.java:74)
            at app//org.eclipse.jetty.io.content.OutputStreamContentSource$AsyncOutputStream.write(OutputStreamContentSource.java:89)
            at app//org.apache.solr.common.util.FastOutputStream.flush(FastOutputStream.java:207)
            at app//org.apache.solr.common.util.FastOutputStream.flushBuffer(FastOutputStream.java:200)
            at app//org.apache.solr.common.util.JavaBinCodec.marshal(JavaBinCodec.java:174)
            at app//org.apache.solr.client.solrj.request.JavaBinUpdateRequestCodec.marshal(JavaBinUpdateRequestCodec.java:88)
            at app//org.apache.solr.client.solrj.request.JavaBinRequestWriter$1.write(JavaBinRequestWriter.java:42)
            at app//org.apache.solr.client.solrj.jetty.HttpJettySolrClient.sendRequest(HttpJettySolrClient.java:758)
            at app//org.apache.solr.client.solrj.jetty.HttpJettySolrClient.request(HttpJettySolrClient.java:481)
            ... 61 more

            Caused by:
            java.io.IOException: Broken pipe
                at java.base/sun.nio.ch.SocketDispatcher.writev0(Native Method)
                at java.base/sun.nio.ch.SocketDispatcher.writev(SocketDispatcher.java:70)
                at java.base/sun.nio.ch.IOUtil.write(IOUtil.java:227)
                at java.base/sun.nio.ch.IOUtil.write(IOUtil.java:158)
                at java.base/sun.nio.ch.SocketChannelImpl.write(SocketChannelImpl.java:574)
                at java.base/java.nio.channels.SocketChannel.write(SocketChannel.java:660)
                at org.eclipse.jetty.io.SocketChannelEndPoint.flush(SocketChannelEndPoint.java:112)
                ... 89 more

org.apache.solr.cloud.RecoveryAfterSoftCommitTest > test suite's output saved to /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/test-results/test/outputs/OUTPUT-org.apache.solr.cloud.RecoveryAfterSoftCommitTest.txt, copied below:
  2> 160594 INFO  (SUITE-RecoveryAfterSoftCommitTest-seed#[4F6C29C0C601D938]-worker) [] o.a.s.SolrTestCase Setting 'solr.configset.default.confdir' system property to test-framework derived value of '/home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/server/solr/configsets/_default/conf'
  2> 160594 INFO  (SUITE-RecoveryAfterSoftCommitTest-seed#[4F6C29C0C601D938]-worker) [] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
  2> 160594 INFO  (SUITE-RecoveryAfterSoftCommitTest-seed#[4F6C29C0C601D938]-worker) [] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.RecoveryAfterSoftCommitTest_4F6C29C0C601D938-001/data-dir-28-001
  2> 160594 INFO  (SUITE-RecoveryAfterSoftCommitTest-seed#[4F6C29C0C601D938]-worker) [] o.a.s.u.ErrorLogMuter Creating ErrorLogMuter-regex-32 for ERROR logs matching regex: ignore_exception
  2> 160595 INFO  (SUITE-RecoveryAfterSoftCommitTest-seed#[4F6C29C0C601D938]-worker) [] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
  2> 160596 INFO  (SUITE-RecoveryAfterSoftCommitTest-seed#[4F6C29C0C601D938]-worker) [] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4.SuppressSSL(bugUrl="None")
  2> 160601 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
  2> 160602 INFO  (ZkTestServer Run Thread) [] o.a.s.c.ZkTestServer client port: /127.0.0.1:0
  2> 160602 INFO  (ZkTestServer Run Thread) [] o.a.s.c.ZkTestServer Starting server
  2> 160603 WARN  (ZkTestServer Run Thread) [] o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
  2> 160702 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.ZkTestServer start zk server on port: 46761
  2> 160703 WARN  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.c.SolrZkClient Using default ZkCredentialsInjector. ZkCredentialsInjector is not secure, it creates an empty list of credentials which leads to 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 160703 WARN  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.c.SolrZkClient Using default ZkACLProvider. DefaultZkACLProvider is not secure, it creates 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 160703 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.c.f.i.CuratorFrameworkImpl Starting
  2> 160705 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.c.f.i.CuratorFrameworkImpl Default schema
  2> 160706 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]-EventThread) [] o.a.c.f.s.ConnectionStateManager State change: CONNECTED
  2> 160707 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]-EventThread) [] o.a.c.f.i.EnsembleTracker New config event received: {}
  2> 160707 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]-EventThread) [] o.a.c.f.i.EnsembleTracker New config event received: {}
  2> 160708 WARN  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.c.SolrZkClient Using default ZkCredentialsInjector. ZkCredentialsInjector is not secure, it creates an empty list of credentials which leads to 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 160708 WARN  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.c.SolrZkClient Using default ZkACLProvider. DefaultZkACLProvider is not secure, it creates 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 160708 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.c.f.i.CuratorFrameworkImpl Starting
  2> 160709 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.c.f.i.CuratorFrameworkImpl Default schema
  2> 160710 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]-EventThread) [] o.a.c.f.s.ConnectionStateManager State change: CONNECTED
  2> 160710 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]-EventThread) [] o.a.c.f.i.EnsembleTracker New config event received: {}
  2> 160710 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]-EventThread) [] o.a.c.f.i.EnsembleTracker New config event received: {}
  2> 160712 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/resources/test/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml
  2> 160713 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/resources/test/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
  2> 160714 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/resources/test/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
  2> 160715 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/resources/test/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
  2> 160716 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/resources/test/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
  2> 160717 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/resources/test/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
  2> 160718 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/resources/test/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml
  2> 160718 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/resources/test/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
  2> 160719 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/resources/test/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
  2> 160720 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/resources/test/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
  2> 160721 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/resources/test/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
  2> 160722 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.AbstractFullDistribZkTestBase Will use NRT replicas unless explicitly asked otherwise
  2> 160889 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
  2> 160889 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
  2> 160889 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.e.j.s.Server jetty-12.0.34; built: 2026-04-01T05:45:03.823Z; git: 57e7adb250592bd15f573e7820be9b64632c6637; jvm 21.0.12.1+1-LTS
  2> 160890 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.e.j.s.DefaultSessionIdManager Session workerName=node0
  2> 160891 WARN  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.e.j.e.s.ServletContextHandler BaseResource file:///home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-cwd/./ is aliased to file:///home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-cwd/ in oeje10s.ServletContextHandler@4e32b39c{/solr,/solr,b=file:///home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-cwd/./,a=STOPPED,h=oeje10s.ServletHandler@6df3aa9b{STOPPED}}. May not be supported in future releases.
  2> 160891 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.e.j.s.h.ContextHandler /solr Base Resource is an alias: file:///home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-cwd/./ -> file:///home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-cwd/
  2> 160891 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.e.j.s.h.ContextHandler Started oeje10s.ServletContextHandler@4e32b39c{/solr,/solr,b=file:///home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-cwd/,a=AVAILABLE,h=oeje10s.ServletHandler@6df3aa9b{STARTED}}
  2> 160891 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.RecoveryAfterSoftCommitTest_4F6C29C0C601D938-001/tempDir-001/control/data, hostPort=35633, coreRootDirectory=/home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.RecoveryAfterSoftCommitTest_4F6C29C0C601D938-001/control-001/cores, replicaType=NRT}
  2> 160891 ERROR (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.u.StartupLoggingUtils Missing Java Option solr.logs.dir. Logging may be missing or incomplete.
  2> 160891 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.s.CoreContainerProvider Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
  2> 160891 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.s.CoreContainerProvider  ___      _       Welcome to Apache Solr™ version 10.1.0
  2> 160892 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.s.CoreContainerProvider / __| ___| |_ _   Starting in cloud mode on port null
  2> 160892 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.s.CoreContainerProvider \__ \/ _ \ | '_|  Install dir: /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr
  2> 160892 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.s.CoreContainerProvider |___/\___/_|_|    Start time: 2026-09-20T09:15:13.712087520Z
  2> 160892 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.s.CoreContainerProvider Solr Home: /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.RecoveryAfterSoftCommitTest_4F6C29C0C601D938-001/control-001 (source: servlet config: solr.solr.home)
  2> 160892 WARN  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.c.SolrZkClient Using default ZkCredentialsInjector. ZkCredentialsInjector is not secure, it creates an empty list of credentials which leads to 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 160892 WARN  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.c.SolrZkClient Using default ZkACLProvider. DefaultZkACLProvider is not secure, it creates 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 160892 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.c.f.i.CuratorFrameworkImpl Starting
  2> 160894 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.c.f.i.CuratorFrameworkImpl Default schema
  2> 160895 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]-EventThread) [] o.a.c.f.s.ConnectionStateManager State change: CONNECTED
  2> 160895 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]-EventThread) [] o.a.c.f.i.EnsembleTracker New config event received: {}
  2> 160895 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]-EventThread) [] o.a.c.f.i.EnsembleTracker New config event received: {}
  2> 160896 INFO  (Curator-Framework-0) [] o.a.c.f.i.CuratorFrameworkImpl backgroundOperationsLoop exiting
  2> 160997 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.SolrXmlConfig Loading solr.xml from /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.RecoveryAfterSoftCommitTest_4F6C29C0C601D938-001/control-001/solr.xml
  2> 161786 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.OpenTelemetryConfigurator OpenTelemetry tracer enabled with simple propagation only.
  2> 161786 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.m.OtelRuntimeJvmMetrics JVM metrics are disabled
  2> 161796 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46761/solr
  2> 161796 WARN  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.c.SolrZkClient Using default ZkCredentialsInjector. ZkCredentialsInjector is not secure, it creates an empty list of credentials which leads to 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 161796 WARN  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.c.SolrZkClient Using default ZkACLProvider. DefaultZkACLProvider is not secure, it creates 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 161796 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.c.f.i.CuratorFrameworkImpl Starting
  2> 161797 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.c.f.i.CuratorFrameworkImpl Default schema
  2> 161799 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]-EventThread) [] o.a.c.f.s.ConnectionStateManager State change: CONNECTED
  2> 161799 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]-EventThread) [] o.a.c.f.i.EnsembleTracker New config event received: {}
  2> 161800 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]-EventThread) [] o.a.c.f.i.EnsembleTracker New config event received: {}
  2> 161800 INFO  (Curator-Framework-0) [] o.a.c.f.i.CuratorFrameworkImpl backgroundOperationsLoop exiting
  2> 161901 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [n:127.0.0.1:35633_solr] o.a.c.f.i.CuratorFrameworkImpl Starting
  2> 161903 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [n:127.0.0.1:35633_solr] o.a.c.f.i.CuratorFrameworkImpl Default schema
  2> 161904 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]-EventThread) [] o.a.c.f.s.ConnectionStateManager State change: CONNECTED
  2> 161905 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]-EventThread) [] o.a.c.f.i.EnsembleTracker New config event received: {}
  2> 161905 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]-EventThread) [] o.a.c.f.i.EnsembleTracker New config event received: {}
  2> 161922 WARN  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [n:127.0.0.1:35633_solr] o.a.s.c.ZkController Contents of zookeeper /security.json are world-readable; consider setting up ACLs as described in https://solr.apache.org/guide/solr/latest/deployment-guide/zookeeper-access-control.html
  2> 161925 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [n:127.0.0.1:35633_solr] o.a.s.c.ZkController The Overseer is enabled.  It will process all cluster commands & state updates.
  2> 161929 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [n:127.0.0.1:35633_solr] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:35633_solr
  2> 161929 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [n:127.0.0.1:35633_solr] o.a.s.c.Overseer Overseer (id=72109286641958916-127.0.0.1:35633_solr-n_0000000000) starting
  2> 161934 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [n:127.0.0.1:35633_solr] o.a.s.c.ZkController Register node as live in ZooKeeper: /live_nodes/127.0.0.1:35633_solr
  2> 161934 INFO  (OverseerStateUpdate-72109286641958916-127.0.0.1:35633_solr-n_0000000000) [n:127.0.0.1:35633_solr] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:35633_solr
  2> 161935 INFO  (OverseerStateUpdate-72109286641958916-127.0.0.1:35633_solr-n_0000000000) [n:127.0.0.1:35633_solr] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
  2> 161942 WARN  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [n:127.0.0.1:35633_solr] o.a.s.c.CoreContainer Not all security plugins configured!  authentication=disabled authorization=disabled.  Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external.  See https://s.apache.org/solrsecurity for more info
  2> 161999 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [n:127.0.0.1:35633_solr] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.RecoveryAfterSoftCommitTest_4F6C29C0C601D938-001/control-001/cores
  2> 162060 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [n:127.0.0.1:35633_solr] o.e.j.e.s.ServletContextHandler Started oeje10s.ServletContextHandler@4e32b39c{/solr,/solr,b=file:///home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-cwd/,a=AVAILABLE,h=oeje10s.ServletHandler@6df3aa9b{STARTED}}
  2> 162061 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [n:127.0.0.1:35633_solr] o.e.j.s.AbstractConnector Started ServerConnector@8bc7b0e{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:38549}
  2> 162061 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [n:127.0.0.1:35633_solr] o.e.j.s.Server Started oejs.Server@153e296a{STARTING}[12.0.34,sto=0] @162081ms
  2> 162064 WARN  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.c.SolrZkClient Using default ZkCredentialsInjector. ZkCredentialsInjector is not secure, it creates an empty list of credentials which leads to 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 162064 WARN  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.c.SolrZkClient Using default ZkACLProvider. DefaultZkACLProvider is not secure, it creates 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 162065 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.c.f.i.CuratorFrameworkImpl Starting
  2> 162066 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.c.f.i.CuratorFrameworkImpl Default schema
  2> 162067 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]-EventThread) [] o.a.c.f.s.ConnectionStateManager State change: CONNECTED
  2> 162067 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]-EventThread) [] o.a.c.f.i.EnsembleTracker New config event received: {}
  2> 162067 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]-EventThread) [] o.a.c.f.i.EnsembleTracker New config event received: {}
  2> 162068 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
  2> 162069 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:46761/solr ready
  2> 162070 INFO  (SocketProxy-Acceptor-35633) [] o.a.s.u.SocketProxy accepted Socket[addr=/127.0.0.1,port=57412,localport=35633], receiveBufferSize: 65536
  2> 162072 INFO  (SocketProxy-Acceptor-35633) [] o.a.s.u.SocketProxy proxy connection Socket[addr=/127.0.0.1,port=38549,localport=44902], receiveBufferSize=65536
  2> 162077 INFO  (OverseerThreadFactory-2354-thread-1) [ c:control_collection t:null-3031] o.a.s.c.a.c.CreateCollectionCmd Create collection control_collection
  2> 162077 INFO  (OverseerThreadFactory-2354-thread-1) [ c:control_collection t:null-3031] o.a.s.c.a.c.CreateCollectionCmd solr.cloud.prs.enabled : false and collection prs : null, isPRS : false
  2> 162080 INFO  (OverseerThreadFactory-2354-thread-1) [ c:control_collection t:null-3031] o.a.s.c.c.ZkStateReader /collections/control_collection/state.json is deleted, stop watching children
  2> 162081 INFO  (zkCallback-2348-thread-1) [] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeCreated path:/collections/control_collection/state.json zxid: -1] for collection [control_collection] has occurred - updating... (live nodes size: [1])
  2> 162086 INFO  (OverseerStateUpdate-72109286641958916-127.0.0.1:35633_solr-n_0000000000) [n:127.0.0.1:35633_solr] o.a.s.c.o.SliceMutator createReplica() {
  2>   "core":"control_collection_shard1_replica_n1",
  2>   "node_name":"127.0.0.1:35633_solr",
  2>   "base_url":"http://127.0.0.1:35633/solr",
  2>   "collection":"control_collection",
  2>   "shard":"shard1",
  2>   "state":"down",
  2>   "type":"NRT",
  2>   "operation":"ADDREPLICA",
  2>   "waitForFinalState":"false"} 
  2> 162188 INFO  (zkCallback-2348-thread-2) [] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json zxid: -1] for collection [control_collection] has occurred - updating... (live nodes size: [1])
  2> 162190 INFO  (SocketProxy-Acceptor-35633) [] o.a.s.u.SocketProxy accepted Socket[addr=/127.0.0.1,port=57414,localport=35633], receiveBufferSize: 65536
  2> 162191 INFO  (SocketProxy-Acceptor-35633) [] o.a.s.u.SocketProxy proxy connection Socket[addr=/127.0.0.1,port=38549,localport=44916], receiveBufferSize=65536
  2> 162193 INFO  (qtp1776312980-3875-null-3031) [n:127.0.0.1:35633_solr x:control_collection_shard1_replica_n1 t:null-3031] o.a.s.h.a.a.CreateCore core create command "org.apache.solr.client.api.model.CreateCoreParams@260450c5"
  2> 162240 INFO  (qtp1776312980-3875-null-3031) [n:127.0.0.1:35633_solr c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1 t:null-3031] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
  2> 162258 INFO  (qtp1776312980-3875-null-3031) [n:127.0.0.1:35633_solr c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1 t:null-3031] o.a.s.c.CoreContainer Creating SolrCore 'control_collection_shard1_replica_n1' using configuration from configset conf1
  2> 162259 INFO  (qtp1776312980-3875-null-3031) [n:127.0.0.1:35633_solr c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1 t:null-3031] o.a.s.c.SolrCore Opening new SolrCore at [/home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.RecoveryAfterSoftCommitTest_4F6C29C0C601D938-001/control-001/cores/control_collection_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.RecoveryAfterSoftCommitTest_4F6C29C0C601D938-001/control-001/cores/control_collection_shard1_replica_n1/data/]
  2> 162259 INFO  (qtp1776312980-3875-null-3031) [n:127.0.0.1:35633_solr c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1 t:null-3031] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=46, maxMergedSegmentMB=50.68434810638428, floorSegmentMB=0.8429241180419922, forceMergeDeletesPctAllowed=0.8609739537446925, segmentsPerTier=29.0, maxCFSSegmentSizeMB=8.796093022208E12, noCFSRatio=0.4508430914976115, deletesPctAllowed=44.26154688461759, targetSearchConcurrency=8
  2> 162265 WARN  (qtp1776312980-3875-null-3031) [n:127.0.0.1:35633_solr c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1 t:null-3031] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A, b=B}}}
  2> 162296 INFO  (qtp1776312980-3875-null-3031) [n:127.0.0.1:35633_solr c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1 t:null-3031] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=2 maxNumLogsToKeep=10
  2> 162296 INFO  (qtp1776312980-3875-null-3031) [n:127.0.0.1:35633_solr c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1 t:null-3031] o.a.s.u.CommitTracker Hard AutoCommit: disabled
  2> 162296 INFO  (qtp1776312980-3875-null-3031) [n:127.0.0.1:35633_solr c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1 t:null-3031] o.a.s.u.CommitTracker Soft AutoCommit: disabled
  2> 162297 INFO  (qtp1776312980-3875-null-3031) [n:127.0.0.1:35633_solr c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1 t:null-3031] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=47, maxMergedSegmentMB=71.85844802856445, floorSegmentMB=1.4434890747070312, forceMergeDeletesPctAllowed=23.632619223618285, segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022208E12, noCFSRatio=0.31693765514548866, deletesPctAllowed=26.009225150749774, targetSearchConcurrency=13
  2> 162299 INFO  (qtp1776312980-3875-null-3031) [n:127.0.0.1:35633_solr c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1 t:null-3031] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
  2> 162299 INFO  (qtp1776312980-3875-null-3031) [n:127.0.0.1:35633_solr c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1 t:null-3031] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
  2> 162300 INFO  (qtp1776312980-3875-null-3031) [n:127.0.0.1:35633_solr c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1 t:null-3031] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
  2> 162301 INFO  (searcherExecutor-2365-thread-1-processing-127.0.0.1:35633_solr control_collection_shard1_replica_n1 null-3031 control_collection shard1 core_node2) [n:127.0.0.1:35633_solr c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1 t:null-3031] o.a.s.c.SolrCore Registered new searcher autowarm time: 0 ms
  2> 162304 INFO  (qtp1776312980-3875-null-3031) [n:127.0.0.1:35633_solr c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1 t:null-3031] o.a.s.c.ZkShardTerms Successful update of terms at /collections/control_collection/terms/shard1 to Terms{values={core_node2=0}, version=0} for registerTerm
  2> 162304 INFO  (qtp1776312980-3875-null-3031) [n:127.0.0.1:35633_solr c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1 t:null-3031] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/control_collection/leaders/shard1
  2> 162311 INFO  (qtp1776312980-3875-null-3031) [n:127.0.0.1:35633_solr c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1 t:null-3031] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
  2> 162311 INFO  (qtp1776312980-3875-null-3031) [n:127.0.0.1:35633_solr c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1 t:null-3031] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
  2> 162311 INFO  (qtp1776312980-3875-null-3031) [n:127.0.0.1:35633_solr c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1 t:null-3031] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:35633/solr/control_collection_shard1_replica_n1/
  2> 162311 INFO  (qtp1776312980-3875-null-3031) [n:127.0.0.1:35633_solr c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1 t:null-3031] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
  2> 162311 INFO  (qtp1776312980-3875-null-3031) [n:127.0.0.1:35633_solr c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1 t:null-3031] o.a.s.c.SyncStrategy http://127.0.0.1:35633/solr/control_collection_shard1_replica_n1/ has no replicas
  2> 162311 INFO  (qtp1776312980-3875-null-3031) [n:127.0.0.1:35633_solr c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1 t:null-3031] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/control_collection/leaders/shard1/leader after winning as /collections/control_collection/leader_elect/shard1/election/72109286641958916-core_node2-n_0000000000
  2> 162416 INFO  (zkCallback-2348-thread-2) [] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json zxid: -1] for collection [control_collection] has occurred - updating... (live nodes size: [1])
  2> 162417 INFO  (qtp1776312980-3875-null-3031) [n:127.0.0.1:35633_solr c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1 t:null-3031] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:35633/solr/control_collection_shard1_replica_n1/ shard1
  2> 162419 INFO  (qtp1776312980-3875-null-3031) [n:127.0.0.1:35633_solr c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1 t:null-3031] o.a.s.c.ZkController I am the leader, no recovery necessary
  2> 162422 INFO  (qtp1776312980-3875-null-3031) [n:127.0.0.1:35633_solr t:null-3031] o.a.s.s.HttpSolrCall [admin] path=/admin/cores params={coreNodeName=core_node2&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&replicaType=NRT} status=0 QTime=230
  2> 162426 INFO  (qtp1776312980-3872-null-3030) [n:127.0.0.1:35633_solr c:control_collection t:null-3030] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
  2> 162522 INFO  (zkCallback-2348-thread-2) [] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json zxid: -1] for collection [control_collection] has occurred - updating... (live nodes size: [1])
  2> 162523 INFO  (qtp1776312980-3872-null-3030) [n:127.0.0.1:35633_solr c:control_collection t:null-3030] o.a.s.s.HttpSolrCall [admin] path=/admin/collections params={collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:35633_solr&wt=javabin} status=0 QTime=449
  2> 162524 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.AbstractFullDistribZkTestBase Waiting to see 1 active replicas in collection: control_collection
  2> 162525 INFO  (Curator-Framework-0) [] o.a.c.f.i.CuratorFrameworkImpl backgroundOperationsLoop exiting
  2> 162630 WARN  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.c.SolrZkClient Using default ZkCredentialsInjector. ZkCredentialsInjector is not secure, it creates an empty list of credentials which leads to 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 162630 WARN  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.c.SolrZkClient Using default ZkACLProvider. DefaultZkACLProvider is not secure, it creates 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 162630 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.c.f.i.CuratorFrameworkImpl Starting
  2> 162631 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.c.f.i.CuratorFrameworkImpl Default schema
  2> 162633 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]-EventThread) [] o.a.c.f.s.ConnectionStateManager State change: CONNECTED
  2> 162633 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]-EventThread) [] o.a.c.f.i.EnsembleTracker New config event received: {}
  2> 162633 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]-EventThread) [] o.a.c.f.i.EnsembleTracker New config event received: {}
  2> 162634 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
  2> 162635 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:46761/solr ready
  2> 162636 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false
  2> 162637 INFO  (SocketProxy-Acceptor-35633) [] o.a.s.u.SocketProxy accepted Socket[addr=/127.0.0.1,port=57424,localport=35633], receiveBufferSize: 65536
  2> 162637 INFO  (SocketProxy-Acceptor-35633) [] o.a.s.u.SocketProxy proxy connection Socket[addr=/127.0.0.1,port=38549,localport=44920], receiveBufferSize=65536
  2> 162642 INFO  (OverseerThreadFactory-2354-thread-2) [ c:collection1 t:null-3033] o.a.s.c.a.c.CreateCollectionCmd Create collection collection1
  2> 162642 INFO  (OverseerThreadFactory-2354-thread-2) [ c:collection1 t:null-3033] o.a.s.c.a.c.CreateCollectionCmd solr.cloud.prs.enabled : false and collection prs : null, isPRS : false
  2> 162645 INFO  (OverseerThreadFactory-2354-thread-2) [ c:collection1 t:null-3033] o.a.s.c.c.ZkStateReader /collections/collection1/state.json is deleted, stop watching children
  2> 162747 INFO  (zkCallback-2348-thread-2) [] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeCreated path:/collections/collection1/state.json zxid: -1] for collection [collection1] has occurred - updating... (live nodes size: [1])
  2> 162748 WARN  (OverseerThreadFactory-2354-thread-2) [ c:collection1 t:null-3033] o.a.s.c.a.c.CreateCollectionCmd It is unusual to create a collection (collection1) without cores.
  2> 162750 INFO  (qtp1776312980-3874-null-3032) [n:127.0.0.1:35633_solr c:collection1 t:null-3032] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
  2> 162751 INFO  (qtp1776312980-3874-null-3032) [n:127.0.0.1:35633_solr c:collection1 t:null-3032] o.a.s.s.HttpSolrCall [admin] path=/admin/collections params={collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=&wt=javabin} status=0 QTime=112
  2> 162752 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.SolrCloudTestCase active slice count: 1 expected: 1
  2> 162752 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
  2> 162752 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.AbstractFullDistribZkTestBase Creating jetty instances pullReplicaCount=0 numOtherReplicas=2
  2> 162936 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.RecoveryAfterSoftCommitTest_4F6C29C0C601D938-001/shard-1-001 of type NRT for shard1
  2> 162939 INFO  (closeThreadPool-2377-thread-1) [] o.a.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
  2> 162939 INFO  (closeThreadPool-2377-thread-1) [] o.a.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
  2> 162939 INFO  (closeThreadPool-2377-thread-1) [] o.e.j.s.Server jetty-12.0.34; built: 2026-04-01T05:45:03.823Z; git: 57e7adb250592bd15f573e7820be9b64632c6637; jvm 21.0.12.1+1-LTS
  2> 162940 INFO  (closeThreadPool-2377-thread-1) [] o.e.j.s.DefaultSessionIdManager Session workerName=node0
  2> 162941 WARN  (closeThreadPool-2377-thread-1) [] o.e.j.e.s.ServletContextHandler BaseResource file:///home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-cwd/./ is aliased to file:///home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-cwd/ in oeje10s.ServletContextHandler@4d1a54de{/solr,/solr,b=file:///home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-cwd/./,a=STOPPED,h=oeje10s.ServletHandler@227e5d0b{STOPPED}}. May not be supported in future releases.
  2> 162941 INFO  (closeThreadPool-2377-thread-1) [] o.e.j.s.h.ContextHandler /solr Base Resource is an alias: file:///home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-cwd/./ -> file:///home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-cwd/
  2> 162941 INFO  (closeThreadPool-2377-thread-1) [] o.e.j.s.h.ContextHandler Started oeje10s.ServletContextHandler@4d1a54de{/solr,/solr,b=file:///home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-cwd/,a=AVAILABLE,h=oeje10s.ServletHandler@227e5d0b{STARTED}}
  2> 162942 INFO  (closeThreadPool-2377-thread-1) [] o.a.s.e.JettySolrRunner Jetty properties: {solrconfig=solrconfig.xml, solr.data.dir=/home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.RecoveryAfterSoftCommitTest_4F6C29C0C601D938-001/tempDir-001/jetty1, hostPort=45011, coreRootDirectory=/home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.RecoveryAfterSoftCommitTest_4F6C29C0C601D938-001/shard-1-001/cores}
  2> 162942 ERROR (closeThreadPool-2377-thread-1) [] o.a.s.u.StartupLoggingUtils Missing Java Option solr.logs.dir. Logging may be missing or incomplete.
  2> 162942 INFO  (closeThreadPool-2377-thread-1) [] o.a.s.s.CoreContainerProvider Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
  2> 162942 INFO  (closeThreadPool-2377-thread-1) [] o.a.s.s.CoreContainerProvider  ___      _       Welcome to Apache Solr™ version 10.1.0
  2> 162942 INFO  (closeThreadPool-2377-thread-1) [] o.a.s.s.CoreContainerProvider / __| ___| |_ _   Starting in cloud mode on port null
  2> 162942 INFO  (closeThreadPool-2377-thread-1) [] o.a.s.s.CoreContainerProvider \__ \/ _ \ | '_|  Install dir: /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr
  2> 162942 INFO  (closeThreadPool-2377-thread-1) [] o.a.s.s.CoreContainerProvider |___/\___/_|_|    Start time: 2026-09-20T09:15:15.762377723Z
  2> 162942 INFO  (closeThreadPool-2377-thread-1) [] o.a.s.s.CoreContainerProvider Solr Home: /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.RecoveryAfterSoftCommitTest_4F6C29C0C601D938-001/shard-1-001 (source: servlet config: solr.solr.home)
  2> 162942 WARN  (closeThreadPool-2377-thread-1) [] o.a.s.c.c.SolrZkClient Using default ZkCredentialsInjector. ZkCredentialsInjector is not secure, it creates an empty list of credentials which leads to 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 162942 WARN  (closeThreadPool-2377-thread-1) [] o.a.s.c.c.SolrZkClient Using default ZkACLProvider. DefaultZkACLProvider is not secure, it creates 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 162943 INFO  (closeThreadPool-2377-thread-1) [] o.a.c.f.i.CuratorFrameworkImpl Starting
  2> 162944 INFO  (closeThreadPool-2377-thread-1) [] o.a.c.f.i.CuratorFrameworkImpl Default schema
  2> 162945 INFO  (closeThreadPool-2377-thread-1-EventThread) [] o.a.c.f.s.ConnectionStateManager State change: CONNECTED
  2> 162946 INFO  (closeThreadPool-2377-thread-1-EventThread) [] o.a.c.f.i.EnsembleTracker New config event received: {}
  2> 162946 INFO  (closeThreadPool-2377-thread-1-EventThread) [] o.a.c.f.i.EnsembleTracker New config event received: {}
  2> 162946 INFO  (Curator-Framework-0) [] o.a.c.f.i.CuratorFrameworkImpl backgroundOperationsLoop exiting
  2> 163047 INFO  (closeThreadPool-2377-thread-1) [] o.a.s.c.SolrXmlConfig Loading solr.xml from /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.RecoveryAfterSoftCommitTest_4F6C29C0C601D938-001/shard-1-001/solr.xml
  2> 163094 INFO  (TEST-RecoveryAfterSoftCommitTest.test-seed#[4F6C29C0C601D938]) [] o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.RecoveryAfterSoftCommitTest_4F6C29C0C601D938-001/shard-2-001 of type NRT for shard1
  2> 163107 INFO  (closeThreadPool-2377-thread-2) [] o.a.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
  2> 163107 INFO  (closeThreadPool-2377-thread-2) [] o.a.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
  2> 163107 INFO  (closeThreadPool-2377-thread-2) [] o.e.j.s.Server jetty-12.0.34; built: 2026-04-01T05:45:03.823Z; git: 57e7adb250592bd15f573e7820be9b64632c6637; jvm 21.0.12.1+1-LTS
  2> 163108 INFO  (closeThreadPool-2377-thread-2) [] o.e.j.s.DefaultSessionIdManager Session workerName=node0
  2> 163108 WARN  (closeThreadPool-2377-thread-2) [] o.e.j.e.s.ServletContextHandler BaseResource file:///home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-cwd/./ is aliased to file:///home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-cwd/ in oeje10s.ServletContextHandler@1014b0fe{/solr,/solr,b=file:///home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-cwd/./,a=STOPPED,h=oeje10s.ServletHandler@79a6fcc5{STOPPED}}. May not be supported in future releases.
  2> 163109 INFO  (closeThreadPool-2377-thread-2) [] o.e.j.s.h.ContextHandler /solr Base Resource is an alias: file:///home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-cwd/./ -> file:///home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-cwd/
  2> 163109 INFO  (closeThreadPool-2377-thread-2) [] o.e.j.s.h.ContextHandler Started oeje10s.ServletContextHandler@1014b0fe{/solr,/solr,b=file:///home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-cwd/,a=AVAILABLE,h=oeje10s.ServletHandler@79a6fcc5{STARTED}}
  2> 163109 INFO  (closeThreadPool-2377-thread-2) [] o.a.s.e.JettySolrRunner Jetty properties: {solrconfig=solrconfig.xml, solr.data.dir=/home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.RecoveryAfterSoftCommitTest_4F6C29C0C601D938-001/tempDir-001/jetty2, hostPort=35389, coreRootDirectory=/home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.RecoveryAfterSoftCommitTest_4F6C29C0C601D938-001/shard-2-001/cores}
  2> 163109 ERROR (closeThreadPool-2377-thread-2) [] o.a.s.u.StartupLoggingUtils Missing Java Option solr.logs.dir. Logging may be missing or incomplete.
  2> 163109 INFO  (closeThreadPool-2377-thread-2) [] o.a.s.s.CoreContainerProvider Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
  2> 163109 INFO  (closeThreadPool-2377-thread-2) [] o.a.s.s.CoreContainerProvider  ___      _       Welcome to Apache Solr™ version 10.1.0
  2> 163109 INFO  (closeThreadPool-2377-thread-2) [] o.a.s.s.CoreContainerProvider / __| ___| |_ _   Starting in cloud mode on port null
  2> 163109 INFO  (closeThreadPool-2377-thread-2) [] o.a.s.s.CoreContainerProvider \__ \/ _ \ | '_|  Install dir: /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr
  2> 163109 INFO  (closeThreadPool-2377-thread-2) [] o.a.s.s.CoreContainerProvider |___/\___/_|_|    Start time: 2026-09-20T09:15:15.929985877Z
  2> 163110 INFO  (closeThreadPool-2377-thread-2) [] o.a.s.s.CoreContainerProvider Solr Home: /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.RecoveryAfterSoftCommitTest_4F6C29C0C601D938-001/shard-2-001 (source: servlet config: solr.solr.home)
  2> 163110 WARN  (closeThreadPool-2377-thread-2) [] o.a.s.c.c.SolrZkClient Using default ZkCredentialsInjector. ZkCredentialsInjector is not secure, it creates an empty list of credentials which leads to 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 163110 WARN  (closeThreadPool-2377-thread-2) [] o.a.s.c.c.SolrZkClient Using default ZkACLProvider. DefaultZkACLProvider is not secure, it creates 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 163110 INFO  (closeThreadPool-2377-thread-2) [] o.a.c.f.i.CuratorFrameworkImpl Starting
  2> 163112 INFO  (closeThreadPool-2377-thread-2) [] o.a.c.f.i.CuratorFrameworkImpl Default schema
  2> 163113 INFO  (closeThreadPool-2377-thread-2-EventThread) [] o.a.c.f.s.ConnectionStateManager State change: CONNECTED
  2> 163113 INFO  (closeThreadPool-2377-thread-2-EventThread) [] o.a.c.f.i.EnsembleTracker New config event received: {}
  2> 163114 INFO  (closeThreadPool-2377-thread-2-EventThread) [] o.a.c.f.i.EnsembleTracker New config event received: {}
  2> 163114 INFO  (Curator-Framework-0) [] o.a.c.f.i.CuratorFrameworkImpl backgroundOperationsLoop exiting
  2> 163215 INFO  (closeThreadPool-2377-thread-2) [] o.a.s.c.SolrXmlConfig Loading solr.xml from /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-tmp/org.apache.solr.cloud.RecoveryAfterSoftCommitTest_4F6C29C0C601D938-001/shard-2-001/solr.xml
  2> 164395 INFO  (closeThreadPool-2377-thread-1) [] o.a.s.m.OtelRuntimeJvmMetrics JVM metrics are disabled
  2> 164402 INFO  (closeThreadPool-2377-thread-1) [] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46761/solr
  2> 164402 WARN  (closeThreadPool-2377-thread-1) [] o.a.s.c.c.SolrZkClient Using default ZkCredentialsInjector. ZkCredentialsInjector is not secure, it creates an empty list of credentials which leads to 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 164402 WARN  (closeThreadPool-2377-thread-1) [] o.a.s.c.c.SolrZkClient Using default ZkACLProvider. DefaultZkACLProvider is not secure, it creates 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 164403 INFO  (closeThreadPool-2377-thread-1) [] o.a.c.f.i.CuratorFrameworkImpl Starting
  2> 164404 INFO  (closeThreadPool-2377-thread-1) [] o.a.c.f.i.CuratorFrameworkImpl Default schema
  2> 164405 INFO  (closeThreadPool-2377-thread-1-EventThread) [] o.a.c.f.s.ConnectionStateManager State change: CONNECTED
  2> 164406 INFO  (closeThreadPool-2377-thread-1-EventThread) [] o.a.c.f.i.EnsembleTracker New config event received: {}
  2> 164406 INFO  (closeThreadPool-2377-thread-1-EventThread) [] o.a.c.f.i.EnsembleTracker New config event received: {}
  2> 164406 INFO  (Curator-Framework-0) [] o.a.c.f.i.CuratorFrameworkImpl backgroundOperationsLoop exiting
  2> 164507 INFO  (closeThreadPool-2377-thread-1) [n:127.0.0.1:45011_solr] o.a.c.f.i.CuratorFrameworkImpl Starting
  2> 164508 INFO  (closeThreadPool-2377-thread-1) [n:127.0.0.1:45011_solr] o.a.c.f.i.CuratorFrameworkImpl Default schema
  2> 164509 INFO  (closeThreadPool-2377-thread-1-EventThread) [] o.a.c.f.s.ConnectionStateManager State change: CONNECTED
  2> 164510 INFO  (closeThreadPool-2377-thread-1-EventThread) [] o.a.c.f.i.EnsembleTracker New config event received: {}
  2> 164510 INFO  (closeThreadPool-2377-thread-1-EventThread) [] o.a.c.f.i.EnsembleTracker New config event received: {}
  2> 164515 WARN  (closeThreadPool-2377-thread-1) [n:127.0.0.1:45011_solr] o.a.s.c.ZkController Contents of zookeeper /security.json are world-readable; consider setting up ACLs as described in https://solr.apache.org/guide/solr/latest/de

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

ocale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
:solr:modules:sql:test (SUCCESS): 36 test(s)

> Task :checkWorkingCopyClean
> Task :solr:modules:sql:wipeTaskTemp
The slowest tests (exceeding 500 ms) during this run:
  65.93s TestCpuAllowedLimit.testDistribLimit (:solr:core)
  61.89s TestCloudJSONFacetSKG.testRandom (:solr:core)
  55.72s TestCpuAllowedLimit.testDistribLimit2 (:solr:core)
  47.20s TestRandomFaceting.testRandomFaceting (:solr:core)
  46.63s TestRandomCollapseQParserPlugin.testRandomCollapseWithSort (:solr:core)
  40.15s HttpJettySolrClientTest.testIdleTimeoutWithHttpClient (:solr:solrj-jetty)
  39.70s BasicDistributedZkTest.test (:solr:core)
  39.40s PeerSyncReplicationTest.test (:solr:core)
  37.09s TestCoordinatorRole.testNRTRestart (:solr:core)
  35.46s TestCloudSearcherWarming.testPeersyncFailureReplicationSuccess (:solr:core)
The slowest suites (exceeding 1s) during this run:
  127.55s TestCpuAllowedLimit (:solr:core)
  78.50s KnnQParserTest (:solr:core)
  76.13s TestCoordinatorRole (:solr:core)
  74.29s TestRecovery (:solr:core)
  67.09s TestCloudJSONFacetSKG (:solr:core)
  64.89s MultiThreadedOCPTest (:solr:core)
  64.83s ReindexCollectionTest (:solr:core)
  61.21s TestTlogReplica (:solr:core)
  57.78s TestRangeQuery (:solr:core)
  53.38s HttpJettySolrClientTest (:solr:solrj-jetty)
ERROR: The following test(s) have failed:
  - org.apache.solr.cloud.RecoveryAfterSoftCommitTest.test (:solr:core)
    Test history: https://develocity.apache.org/scans/tests?search.rootProjectNames=solr-root&tests.container=org.apache.solr.cloud.RecoveryAfterSoftCommitTest&tests.test=test http://fucit.org/solr-jenkins-reports/history-trend-of-recent-failures.html#series/org.apache.solr.cloud.RecoveryAfterSoftCommitTest.test
    Test output: /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/test-results/test/outputs/OUTPUT-org.apache.solr.cloud.RecoveryAfterSoftCommitTest.txt
    Reproduce with: ./gradlew :solr:core:test --tests "org.apache.solr.cloud.RecoveryAfterSoftCommitTest.test" -Ptests.haltonfailure=false "-Ptests.jvmargs=-XX:TieredStopAtLevel=1 -XX:+UseParallelGC -XX:ActiveProcessorCount=1 -XX:ReservedCodeCacheSize=120m" -Ptests.seed=4F6C29C0C601D938 -Ptests.multiplier=2 -Ptests.useSecurityManager=true -Ptests.badapples=false -Ptests.file.encoding=US-ASCII


[Incubating] Problems report is available at: file:///home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/build/reports/problems/problems-report.html

Deprecated Gradle features were used in this build, making it incompatible with Gradle 10.

You can use '--warning-mode all' to show the individual deprecation warnings and determine if they come from your own scripts or plugins.

For more on this, please refer to https://docs.gradle.org/9.7.0/userguide/command_line_interface.html#sec:command_line_warnings in the Gradle documentation.

BUILD SUCCESSFUL in 38m 32s
156 actionable tasks: 156 executed

Publishing Build Scan to Develocity...

The Develocity server (develocity.apache.org) rejected the credential with prefix '7x3jzizm4zpygv7psbkg6byvm4'.
Your credential has expired.

Build step 'Invoke Gradle script' changed build result to SUCCESS
Archiving artifacts
‘**/*.events’ doesn’t match anything: ‘**’ exists but not ‘**/*.events’
No artifacts found that match the file pattern "**/*.events,heapdumps/**,**/hs_err_pid*". Configuration error?
Recording test results
FATAL: Failed to save the JUnit test result
java.io.IOException: java.lang.RuntimeException: Failed to serialize hudson.tasks.junit.TestResult#suites for class hudson.tasks.junit.TestResult
	at hudson.XmlFile.write(XmlFile.java:223)
	at PluginClassLoader for junit//hudson.tasks.junit.TestResultAction.setResult(TestResultAction.java:135)
	at PluginClassLoader for junit//hudson.tasks.junit.TestResultAction.<init>(TestResultAction.java:96)
	at PluginClassLoader for junit//hudson.tasks.junit.JUnitResultArchiver.parseAndSummarize(JUnitResultArchiver.java:301)
	at PluginClassLoader for junit//hudson.tasks.junit.JUnitResultArchiver.perform(JUnitResultArchiver.java:194)
	at jenkins.tasks.SimpleBuildStep.perform(SimpleBuildStep.java:123)
	at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:80)
	at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
	at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:818)
	at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:767)
	at hudson.model.Build$BuildExecution.post2(Build.java:179)
	at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:711)
	at hudson.model.Run.execute(Run.java:1856)
	at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
	at hudson.model.ResourceController.execute(ResourceController.java:101)
	at hudson.model.Executor.run(Executor.java:446)
Caused by: java.lang.RuntimeException: Failed to serialize hudson.tasks.junit.TestResult#suites for class hudson.tasks.junit.TestResult
	at hudson.util.RobustReflectionConverter$2.writeField(RobustReflectionConverter.java:274)
	at hudson.util.RobustReflectionConverter$2.visit(RobustReflectionConverter.java:241)
	at com.thoughtworks.xstream.converters.reflection.PureJavaReflectionProvider.visitSerializableFields(PureJavaReflectionProvider.java:174)
	at hudson.util.RobustReflectionConverter.doMarshal(RobustReflectionConverter.java:226)
	at hudson.util.RobustReflectionConverter.marshal(RobustReflectionConverter.java:163)
	at com.thoughtworks.xstream.core.AbstractReferenceMarshaller.convert(AbstractReferenceMarshaller.java:68)
	at com.thoughtworks.xstream.core.TreeMarshaller.convertAnother(TreeMarshaller.java:59)
	at com.thoughtworks.xstream.core.TreeMarshaller.convertAnother(TreeMarshaller.java:44)
	at com.thoughtworks.xstream.core.TreeMarshaller.start(TreeMarshaller.java:83)
	at com.thoughtworks.xstream.core.AbstractTreeMarshallingStrategy.marshal(AbstractTreeMarshallingStrategy.java:37)
	at com.thoughtworks.xstream.XStream.marshal(XStream.java:1307)
	at com.thoughtworks.xstream.XStream.marshal(XStream.java:1296)
	at com.thoughtworks.xstream.XStream.toXML(XStream.java:1269)
	at hudson.XmlFile.write(XmlFile.java:216)
	... 15 more
Caused by: java.lang.RuntimeException: Failed to serialize hudson.tasks.junit.SuiteResult#stderr for class hudson.tasks.junit.SuiteResult
	at hudson.util.RobustReflectionConverter$2.writeField(RobustReflectionConverter.java:274)
	at hudson.util.RobustReflectionConverter$2.visit(RobustReflectionConverter.java:241)
	at com.thoughtworks.xstream.converters.reflection.PureJavaReflectionProvider.visitSerializableFields(PureJavaReflectionProvider.java:174)
	at hudson.util.RobustReflectionConverter.doMarshal(RobustReflectionConverter.java:226)
	at hudson.util.RobustReflectionConverter.marshal(RobustReflectionConverter.java:163)
	at com.thoughtworks.xstream.core.AbstractReferenceMarshaller.convert(AbstractReferenceMarshaller.java:68)
	at com.thoughtworks.xstream.core.TreeMarshaller.convertAnother(TreeMarshaller.java:59)
	at com.thoughtworks.xstream.core.TreeMarshaller.convertAnother(TreeMarshaller.java:44)
	at com.thoughtworks.xstream.core.AbstractReferenceMarshaller$1.convertAnother(AbstractReferenceMarshaller.java:87)
	at com.thoughtworks.xstream.converters.collections.AbstractCollectionConverter.writeBareItem(AbstractCollectionConverter.java:94)
	at com.thoughtworks.xstream.converters.collections.AbstractCollectionConverter.writeItem(AbstractCollectionConverter.java:66)
	at com.thoughtworks.xstream.converters.collections.AbstractCollectionConverter.writeCompleteItem(AbstractCollectionConverter.java:81)
	at com.thoughtworks.xstream.converters.collections.CollectionConverter.marshal(CollectionConverter.java:75)
	at com.thoughtworks.xstream.core.AbstractReferenceMarshaller.convert(AbstractReferenceMarshaller.java:68)
	at com.thoughtworks.xstream.core.TreeMarshaller.convertAnother(TreeMarshaller.java:59)
	at com.thoughtworks.xstream.core.AbstractReferenceMarshaller$1.convertAnother(AbstractReferenceMarshaller.java:83)
	at hudson.util.RobustReflectionConverter.marshallField(RobustReflectionConverter.java:283)
	at hudson.util.RobustReflectionConverter$2.writeField(RobustReflectionConverter.java:270)
	... 28 more
Caused by: com.thoughtworks.xstream.io.StreamException: Invalid character 0xdd3c in XML stream
	at hudson.util.PrettyPrintWriter.lambda$writeText$0(PrettyPrintWriter.java:253)
	at java.base/java.lang.StringUTF16$CodePointsSpliterator.advance(StringUTF16.java:1319)
	at java.base/java.lang.StringUTF16$CodePointsSpliterator.forEachRemaining(StringUTF16.java:1291)
	at java.base/java.util.stream.IntPipeline$Head.forEach(IntPipeline.java:617)
	at hudson.util.PrettyPrintWriter.writeText(PrettyPrintWriter.java:214)
	at hudson.util.PrettyPrintWriter.writeText(PrettyPrintWriter.java:210)
	at hudson.util.PrettyPrintWriter.setValue(PrettyPrintWriter.java:192)
	at com.thoughtworks.xstream.io.WriterWrapper.setValue(WriterWrapper.java:45)
	at com.thoughtworks.xstream.converters.SingleValueConverterWrapper.marshal(SingleValueConverterWrapper.java:45)
	at com.thoughtworks.xstream.core.AbstractReferenceMarshaller.convert(AbstractReferenceMarshaller.java:50)
	at com.thoughtworks.xstream.core.TreeMarshaller.convertAnother(TreeMarshaller.java:59)
	at com.thoughtworks.xstream.core.AbstractReferenceMarshaller$1.convertAnother(AbstractReferenceMarshaller.java:83)
	at hudson.util.RobustReflectionConverter.marshallField(RobustReflectionConverter.java:283)
	at hudson.util.RobustReflectionConverter$2.writeField(RobustReflectionConverter.java:270)
	... 45 more
[Checks API] No suitable checks publisher found.
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)

[JENKINS] Solr » Solr-Test-10.x - Build # 2540 - Still Unstable!

Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://ci-builds.apache.org/job/Solr/job/Solr-Test-10.x/2540/

1 tests failed.
FAILED:  org.apache.solr.search.TestFiltering.testRandomFiltering

Error Message:
java.lang.AssertionError: FAILURE: indexSize=38 iiter=2 qiter=186 request=[q, {!cache=true tag=t} val_i:0 val_i:1 val_i:2 val_i:4 val_i:8 val_i:9 val_i:10 val_i:12 val_i:14 val_i:15 val_i:19 val_i:21 val_i:25 val_i:26 val_i:27 val_i:28 val_i:35 val_i:37, fq, -_query_:"val_s:[00010 TO 00038}", fq, {! cost=83}val_s:{00016 TO 00044] OR val_s:[00017 TO 00045}, fq, {! cost=82}id:RAND-1873211473 OR val_i:[00006 TO 00041}, fq, {! cache=true tag=t}val_i:{00034 TO 00065} OR id:RAND-999887488, facet, true, facet.query, *:*, facet.query, {!key=multiSelect ex=t}*:*, facet.query, {!key=facetQuery cache=false} val_i:0 val_i:1 val_i:2 val_i:3 val_i:6 val_i:9 val_i:10 val_i:11 val_i:12 val_i:14 val_i:15 val_i:20 val_i:23 val_i:24 val_i:26 val_i:27 val_i:28 val_i:32 val_i:33 val_i:34 val_i:35 val_i:36]

Stack Trace:
java.lang.AssertionError: FAILURE: indexSize=38 iiter=2 qiter=186 request=[q, {!cache=true tag=t} val_i:0 val_i:1 val_i:2 val_i:4 val_i:8 val_i:9 val_i:10 val_i:12 val_i:14 val_i:15 val_i:19 val_i:21 val_i:25 val_i:26 val_i:27 val_i:28 val_i:35 val_i:37, fq, -_query_:"val_s:[00010 TO 00038}", fq, {! cost=83}val_s:{00016 TO 00044] OR val_s:[00017 TO 00045}, fq, {! cost=82}id:RAND-1873211473 OR val_i:[00006 TO 00041}, fq, {! cache=true tag=t}val_i:{00034 TO 00065} OR id:RAND-999887488, facet, true, facet.query, *:*, facet.query, {!key=multiSelect ex=t}*:*, facet.query, {!key=facetQuery cache=false} val_i:0 val_i:1 val_i:2 val_i:3 val_i:6 val_i:9 val_i:10 val_i:11 val_i:12 val_i:14 val_i:15 val_i:20 val_i:23 val_i:24 val_i:26 val_i:27 val_i:28 val_i:32 val_i:33 val_i:34 val_i:35 val_i:36]
	at __randomizedtesting.SeedInfo.seed([6D04FB0D4D019170:726758C8A826D179]:0)
	at org.junit.Assert.fail(Assert.java:89)
	at org.apache.solr.search.TestFiltering.testRandomFiltering(TestFiltering.java:575)
	at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103)
	at java.base/java.lang.reflect.Method.invoke(Method.java:580)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1780)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:959)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:995)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:1009)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:80)
	at org.junit.rules.RunRules.evaluate(RunRules.java:20)
	at org.apache.lucene.tests.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:48)
	at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
	at org.apache.lucene.tests.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:45)
	at org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
	at org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
	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:390)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:843)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:490)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:968)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:853)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:904)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:915)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:80)
	at org.junit.rules.RunRules.evaluate(RunRules.java:20)
	at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.tests.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.tests.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
	at org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
	at org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
	at org.apache.lucene.tests.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.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:390)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:850)
	at java.base/java.lang.Thread.run(Thread.java:1583)




Build Log:
[...truncated 11 lines...]
ERROR: Workspace has a .git repository, but it appears to be corrupt.
hudson.plugins.git.GitException: Command "git rev-parse --resolve-git-dir /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/.git" returned status code 128:
stdout: 
stderr: fatal: not a gitdir '/home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/.git'

	at PluginClassLoader for git-client//org.jenkinsci.plugins.gitclient.CliGitAPIImpl.launchCommandIn(CliGitAPIImpl.java:2848)
	at PluginClassLoader for git-client//org.jenkinsci.plugins.gitclient.CliGitAPIImpl.launchCommandIn(CliGitAPIImpl.java:2768)
	at PluginClassLoader for git-client//org.jenkinsci.plugins.gitclient.CliGitAPIImpl.launchCommandIn(CliGitAPIImpl.java:2763)
	at PluginClassLoader for git-client//org.jenkinsci.plugins.gitclient.CliGitAPIImpl.launchCommand(CliGitAPIImpl.java:2052)
	at PluginClassLoader for git-client//org.jenkinsci.plugins.gitclient.CliGitAPIImpl.launchCommand(CliGitAPIImpl.java:2064)
	at PluginClassLoader for git-client//org.jenkinsci.plugins.gitclient.CliGitAPIImpl.hasGitRepo(CliGitAPIImpl.java:404)
	at PluginClassLoader for git-client//hudson.plugins.git.GitAPI.hasGitRepo(GitAPI.java:281)
	at jdk.internal.reflect.GeneratedMethodAccessor31.invoke(Unknown Source)
	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.base/java.lang.reflect.Method.invoke(Method.java:569)
	at hudson.remoting.RemoteInvocationHandler$RPCRequest.perform(RemoteInvocationHandler.java:986)
	at hudson.remoting.RemoteInvocationHandler$RPCRequest.call(RemoteInvocationHandler.java:961)
	at hudson.remoting.RemoteInvocationHandler$RPCRequest.call(RemoteInvocationHandler.java:907)
	at hudson.remoting.UserRequest.perform(UserRequest.java:225)
	at hudson.remoting.UserRequest.perform(UserRequest.java:50)
	at hudson.remoting.Request$2.run(Request.java:391)
	at hudson.remoting.InterceptingExecutorService.lambda$wrap$0(InterceptingExecutorService.java:81)
	at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136)
	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
	at java.base/java.lang.Thread.run(Thread.java:840)
Cloning the remote Git repository
Cloning repository https://gitbox.apache.org/repos/asf/solr.git
 > git init /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x # timeout=10
Fetching upstream changes from https://gitbox.apache.org/repos/asf/solr.git
 > git --version # timeout=10
 > git --version # 'git version 2.43.0'
 > git fetch --tags --force --progress -- https://gitbox.apache.org/repos/asf/solr.git +refs/heads/*:refs/remotes/origin/* # timeout=10
 > git config remote.origin.url https://gitbox.apache.org/repos/asf/solr.git # timeout=10
 > git config --add remote.origin.fetch +refs/heads/*:refs/remotes/origin/* # timeout=10
Avoid second fetch
 > git rev-parse refs/remotes/origin/branch_10x^{commit} # timeout=10
Checking out Revision f9181508ba80fb1b66099adff24c7218e348274e (refs/remotes/origin/branch_10x)
 > git config core.sparsecheckout # timeout=10
 > git checkout -f f9181508ba80fb1b66099adff24c7218e348274e # timeout=10
 > git branch -a -v --no-abbrev # timeout=10
 > git checkout -b branch_10x f9181508ba80fb1b66099adff24c7218e348274e # timeout=10
Commit message: "SOLR-18442: Fix OpenTelemetry Observable gauge memory leak"
 > git rev-list --no-walk f9181508ba80fb1b66099adff24c7218e348274e # timeout=10
No emails were triggered.
provisioning config files...
copy managed file [gradle.properties] to file:/home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/gradle.properties
[Gradle] - Launching build.
[Solr-Test-10.x] $ /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/gradlew -Dtests.haltonfailure=false -Dtests.badapples=false --continue test
Downloading gradle-wrapper.jar from https://raw.githubusercontent.com/gradle/gradle/v8.10.2/gradle/wrapper/gradle-wrapper.jar
To honour the JVM settings for this build a single-use Daemon process will be forked. For more on this, please refer to https://docs.gradle.org/9.7.0/userguide/gradle_daemon.html#sec:disabling_the_daemon in the Gradle documentation.
Daemon will be stopped at the end of the build 

> Task :build-infra:compileJava
Note: /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/build-tools/build-infra/src/main/java/org/apache/lucene/gradle/Checksum.java uses or overrides a deprecated API.
Note: Recompile with -Xlint:deprecation for details.

> Task :build-infra:pluginDescriptors
> Task :build-infra:processResources
> Task :build-infra:classes
> Task :build-infra:jar
> Task :gitStatus
> Task :checkJdkInternalsExportedToGradle

> Task :solr:api:compileJava
Note: Some input files use or override a deprecated API.
Note: Recompile with -Xlint:deprecation for details.

> Task :solr:api:processResources NO-SOURCE
> Task :solr:api:classes
> Task :solr:api:jar

> Task :randomizationInfo
Running tests with randomization seed: tests.seed=6D04FB0D4D019170

> Task :solr:api:resolve
> Task :solr:api:processTestResources
> Task :solr:core:processResources
> Task :solr:solrj:processResources
> Task :solr:solrj-jetty:processResources NO-SOURCE
> Task :solr:solrj-streaming:processResources
> Task :solr:solrj-zookeeper:processResources NO-SOURCE
> Task :solr:test-framework:processResources
> Task :solr:benchmark:processResources
> Task :solr:benchmark:processTestResources
> Task :solr:core:processTestResources
> Task :solr:modules:analysis-extras:processResources NO-SOURCE
> Task :solr:cross-dc-manager:processResources NO-SOURCE
> Task :solr:cross-dc-manager:processTestResources
> Task :solr:modules:cross-dc:processResources NO-SOURCE
> Task :solr:modules:opentelemetry:processResources NO-SOURCE
> Task :solr:server:compileJava SKIPPED
> Task :solr:server:processResources NO-SOURCE
> Task :solr:server:classes UP-TO-DATE
> Task :solr:server:compileTestJava NO-SOURCE
> Task :solr:server:processTestResources NO-SOURCE
> Task :solr:server:testClasses UP-TO-DATE
> Task :solr:server:test NO-SOURCE
> Task :solr:server:wipeTaskTemp
> Task :solr:solr-ref-guide:compileJava NO-SOURCE
> Task :solr:solr-ref-guide:processResources NO-SOURCE
> Task :solr:solr-ref-guide:classes UP-TO-DATE
> Task :solr:solr-ref-guide:copySolrjTestResources
> Task :solr:solr-ref-guide:processTestResources NO-SOURCE
> Task :solr:modules:sql:processResources
> Task :solr:solrj:processTestResources
> Task :solr:solrj-jetty:processTestResources
> Task :solr:solrj-streaming:processTestResources
> Task :solr:solrj-zookeeper:processTestResources
> Task :solr:test-framework:processTestResources
> Task :solr:webapp:processResources NO-SOURCE
> Task :solr:webapp:processTestResources
> Task :solr:modules:analysis-extras:processTestResources
> Task :solr:modules:clustering:processResources NO-SOURCE
> Task :solr:modules:clustering:processTestResources
> Task :solr:modules:cross-dc:processTestResources
> Task :solr:modules:cuvs:processResources NO-SOURCE
> Task :solr:modules:cuvs:processTestResources
> Task :solr:modules:extraction:processResources
> Task :solr:modules:extraction:processTestResources
> Task :solr:modules:gcs-repository:processResources NO-SOURCE
> Task :solr:modules:gcs-repository:processTestResources
> Task :solr:modules:jwt-auth:processResources NO-SOURCE
> Task :solr:modules:jwt-auth:processTestResources
> Task :solr:modules:langid:processResources NO-SOURCE
> Task :solr:modules:langid:processTestResources
> Task :solr:modules:language-models:processResources NO-SOURCE
> Task :solr:modules:language-models:processTestResources
> Task :solr:modules:ltr:processResources NO-SOURCE
> Task :solr:modules:ltr:processTestResources
> Task :solr:modules:opentelemetry:processTestResources
> Task :solr:modules:s3-repository:processResources NO-SOURCE
> Task :solr:modules:s3-repository:processTestResources
> Task :solr:modules:scripting:processResources NO-SOURCE
> Task :solr:modules:scripting:processTestResources
> Task :solr:modules:sql:copySolrCoreTestResources
> Task :solr:modules:sql:processTestResources

> Task :solr:solrj:openApiGenerate
Cleaned up output directory /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/solrj/build/generated before code generation.
[openApiGenerate] Worker isolation: classloader (fast startup, but generator classes accumulate in Gradle daemon Metaspace - consider workerIsolation = "process" if you hit metaspace pressure)
File (reserved word) cannot be used as model name. Renamed to ModelFile
############################################################################################
# Thanks for using OpenAPI Generator.                                                      #
# We appreciate your support! Please consider donating to help us maintain this project.   #
# https://opencollective.com/openapi_generator/donate                                      #
############################################################################################
Successfully generated code to /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/solrj/build/generated

> Task :solr:solrj:generatedSpotlessHelper
> Task :solr:solrj:generatedSpotless

> Task :solr:solrj:compileJava
Note: Some input files use or override a deprecated API.
Note: Recompile with -Xlint:deprecation for details.

> Task :solr:solrj-jetty:compileJava
Note: /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/solrj-jetty/src/java/org/apache/solr/client/solrj/jetty/HttpJettySolrClient.java uses or overrides a deprecated API.
Note: Recompile with -Xlint:deprecation for details.

> Task :solr:solrj-streaming:compileJava
Note: Some input files use or override a deprecated API.
Note: Recompile with -Xlint:deprecation for details.

> Task :solr:solrj-zookeeper:compileJava
> Task :solr:core:compileJava
Note: Some input files use or override a deprecated API.
Note: Recompile with -Xlint:deprecation for details.

> Task :solr:test-framework:compileJava
Note: Some input files use or override a deprecated API.
Note: Recompile with -Xlint:deprecation for details.

> Task :solr:api:compileTestJava
> Task :solr:api:testClasses
> Task :solr:core:classes
> Task :solr:core:jar
> Task :solr:solrj:classes
> Task :solr:solrj:jar
> Task :solr:solrj-jetty:classes
> Task :solr:solrj-jetty:jar
> Task :solr:solrj-streaming:classes
> Task :solr:solrj-streaming:jar
> Task :solr:solrj-zookeeper:classes
> Task :solr:solrj-zookeeper:jar
> Task :solr:test-framework:classes
> Task :solr:test-framework:jar

> Task :solr:api:test
WARNING: Using incubator modules: jdk.incubator.vector
WARNING: Using incubator modules: jdk.incubator.vector
WARNING: A command line option has enabled the Security Manager
WARNING: The Security Manager is deprecated and will be removed in a future release
WARNING: A command line option has enabled the Security Manager
WARNING: The Security Manager is deprecated and will be removed in a future release
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
:solr:api:test (SUCCESS): 19 test(s)

> Task :solr:api:wipeTaskTemp
> Task :solr:benchmark:compileJava
> Task :solr:benchmark:classes
> Task :solr:benchmark:compileTestJava
> Task :solr:benchmark:testClasses

> Task :solr:benchmark:test
WARNING: Using incubator modules: jdk.incubator.vector
WARNING: Using incubator modules: jdk.incubator.vector
WARNING: Using incubator modules: jdk.incubator.vector
WARNING: A command line option has enabled the Security Manager
WARNING: The Security Manager is deprecated and will be removed in a future release
WARNING: A command line option has enabled the Security Manager
WARNING: The Security Manager is deprecated and will be removed in a future release
WARNING: A command line option has enabled the Security Manager
WARNING: The Security Manager is deprecated and will be removed in a future release
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
:solr:benchmark:test (SUCCESS): 10 test(s)

> Task :solr:benchmark:wipeTaskTemp
> Task :solr:core:compileTestJava
Note: Some input files use or override a deprecated API.
Note: Recompile with -Xlint:deprecation for details.

> Task :solr:core:testClasses

> Task :solr:modules:analysis-extras:compileJava
Note: /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/modules/analysis-extras/src/java/org/apache/solr/schema/ICUCollationField.java uses or overrides a deprecated API.
Note: Recompile with -Xlint:deprecation for details.

> Task :solr:modules:analysis-extras:classes
> Task :solr:modules:analysis-extras:jar

> Task :solr:core:test
WARNING: Using incubator modules: jdk.incubator.vector
WARNING: Using incubator modules: jdk.incubator.vector
WARNING: Using incubator modules: jdk.incubator.vector
WARNING: Using incubator modules: jdk.incubator.vector
WARNING: A command line option has enabled the Security Manager
WARNING: The Security Manager is deprecated and will be removed in a future release
WARNING: A command line option has enabled the Security Manager
WARNING: The Security Manager is deprecated and will be removed in a future release
WARNING: A command line option has enabled the Security Manager
WARNING: The Security Manager is deprecated and will be removed in a future release
WARNING: A command line option has enabled the Security Manager
WARNING: The Security Manager is deprecated and will be removed in a future release
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.

[61.136s][warning][jfr,system] Could not initialize JDK events. access denied ("java.lang.RuntimePermission" "accessClassInPackage.jdk.internal.event")

> Task :solr:core:test
WARNING: Test org.apache.solr.TestRandomFaceting wrote 24,524,376 bytes of output.
WARNING: Test org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates wrote 14,229,525 bytes of output.
WARNING: Test org.apache.solr.cloud.TestRandomFlRTGCloud wrote 11,473,753 bytes of output.

[482.826s][warning][jfr,system] Could not initialize JDK events. access denied ("java.lang.RuntimePermission" "accessClassInPackage.jdk.internal.event")
[756.253s][warning][jfr,system] Could not initialize JDK events. access denied ("java.lang.RuntimePermission" "accessClassInPackage.jdk.internal.event")
[867.727s][warning][jfr,system] Could not initialize JDK events. access denied ("java.lang.RuntimePermission" "accessClassInPackage.jdk.internal.event")

> Task :solr:core:test
WARNING: Test org.apache.solr.search.TestRangeQuery wrote 15,326,249 bytes of output.
WARNING: Test org.apache.solr.search.facet.TestCloudJSONFacetJoinDomain wrote 11,482,082 bytes of output.
WARNING: Test org.apache.solr.search.facet.TestCloudJSONFacetSKG wrote 11,712,032 bytes of output.

TestFiltering > testRandomFiltering FAILED
    java.lang.AssertionError: FAILURE: indexSize=38 iiter=2 qiter=186 request=[q, {!cache=true tag=t} val_i:0 val_i:1 val_i:2 val_i:4 val_i:8 val_i:9 val_i:10 val_i:12 val_i:14 val_i:15 val_i:19 val_i:21 val_i:25 val_i:26 val_i:27 val_i:28 val_i:35 val_i:37, fq, -_query_:"val_s:[00010 TO 00038}", fq, {! cost=83}val_s:{00016 TO 00044] OR val_s:[00017 TO 00045}, fq, {! cost=82}id:RAND-1873211473 OR val_i:[00006 TO 00041}, fq, {! cache=true tag=t}val_i:{00034 TO 00065} OR id:RAND-999887488, facet, true, facet.query, *:*, facet.query, {!key=multiSelect ex=t}*:*, facet.query, {!key=facetQuery cache=false} val_i:0 val_i:1 val_i:2 val_i:3 val_i:6 val_i:9 val_i:10 val_i:11 val_i:12 val_i:14 val_i:15 val_i:20 val_i:23 val_i:24 val_i:26 val_i:27 val_i:28 val_i:32 val_i:33 val_i:34 val_i:35 val_i:36]
        at __randomizedtesting.SeedInfo.seed([6D04FB0D4D019170:726758C8A826D179]:0)
        at org.junit.Assert.fail(Assert.java:89)
        at org.apache.solr.search.TestFiltering.testRandomFiltering(TestFiltering.java:575)
        at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103)
        at java.base/java.lang.reflect.Method.invoke(Method.java:580)
        at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1780)
        at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:959)
        at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:995)
        at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:1009)
        at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:80)
        at org.junit.rules.RunRules.evaluate(RunRules.java:20)
        at org.apache.lucene.tests.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:48)
        at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
        at org.apache.lucene.tests.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:45)
        at org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
        at org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
        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:390)
        at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:843)
        at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:490)
        at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:968)
        at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:853)
        at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:904)
        at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:915)
        at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
        at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:80)
        at org.junit.rules.RunRules.evaluate(RunRules.java:20)
        at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
        at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at org.apache.lucene.tests.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
        at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at org.apache.lucene.tests.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at org.apache.lucene.tests.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
        at org.apache.lucene.tests.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
        at org.apache.lucene.tests.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
        at org.apache.lucene.tests.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.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:390)
        at com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:850)
        at java.base/java.lang.Thread.run(Thread.java:1583)

org.apache.solr.search.TestFiltering > test suite's output saved to /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/test-results/test/outputs/OUTPUT-org.apache.solr.search.TestFiltering.txt, copied below:
  2> 1022252 INFO  (SUITE-TestFiltering-seed#[6D04FB0D4D019170]-worker) [] o.a.s.SolrTestCase Setting 'solr.configset.default.confdir' system property to test-framework derived value of '/home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/server/solr/configsets/_default/conf'
  2> 1022252 INFO  (SUITE-TestFiltering-seed#[6D04FB0D4D019170]-worker) [] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
  2> 1022252 INFO  (SUITE-TestFiltering-seed#[6D04FB0D4D019170]-worker) [] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-tmp/org.apache.solr.search.TestFiltering_6D04FB0D4D019170-001/data-dir-186-001
  2> 1022252 WARN  (SUITE-TestFiltering-seed#[6D04FB0D4D019170]-worker) [] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2
  2> 1022252 INFO  (SUITE-TestFiltering-seed#[6D04FB0D4D019170]-worker) [] o.a.s.u.ErrorLogMuter Creating ErrorLogMuter-regex-17737 for ERROR logs matching regex: ignore_exception
  2> 1022253 INFO  (SUITE-TestFiltering-seed#[6D04FB0D4D019170]-worker) [] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
  2> 1022254 INFO  (SUITE-TestFiltering-seed#[6D04FB0D4D019170]-worker) [] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, clientAuth=0.0/0.0)
  2> 1022254 INFO  (SUITE-TestFiltering-seed#[6D04FB0D4D019170]-worker) [] o.a.s.SolrTestCaseJ4 ####initCore
  2> 1022258 INFO  (SUITE-TestFiltering-seed#[6D04FB0D4D019170]-worker) [] o.a.s.c.SolrResourceLoader Added lib dirs to classloader: [/home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/resources/test/solr/collection1/lib, /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/resources/test/solr/collection1/lib/classes]
  2> 1022273 WARN  (SUITE-TestFiltering-seed#[6D04FB0D4D019170]-worker) [] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
  2> 1022290 INFO  (SUITE-TestFiltering-seed#[6D04FB0D4D019170]-worker) [] o.a.s.s.IndexSchema Loaded schema example/1.7 with uniqueid field id
  2> 1022864 INFO  (SUITE-TestFiltering-seed#[6D04FB0D4D019170]-worker) [] o.a.s.c.OpenTelemetryConfigurator OpenTelemetry tracer enabled with simple propagation only.
  2> 1022864 INFO  (SUITE-TestFiltering-seed#[6D04FB0D4D019170]-worker) [] o.a.s.m.OtelRuntimeJvmMetrics JVM metrics are disabled
  2> 1022870 WARN  (SUITE-TestFiltering-seed#[6D04FB0D4D019170]-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
  2> 1022878 INFO  (coreLoadExecutor-16273-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader Added lib dirs to classloader: [/home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/resources/test/solr/collection1/lib, /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/resources/test/solr/collection1/lib/classes]
  2> 1022900 WARN  (coreLoadExecutor-16273-thread-1) [ x:collection1] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
  2> 1022918 INFO  (coreLoadExecutor-16273-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema example/1.7 with uniqueid field id
  2> 1022930 INFO  (coreLoadExecutor-16273-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/resources/test/solr/collection1
  2> 1022930 INFO  (coreLoadExecutor-16273-thread-1) [ x:collection1] o.a.s.c.SolrCore Opening new SolrCore at [/home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/resources/test/solr/collection1], dataDir=[/home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/tmp/tests-tmp/org.apache.solr.search.TestFiltering_6D04FB0D4D019170-001/data-dir-186-001/]
  2> 1022931 INFO  (coreLoadExecutor-16273-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=19, maxMergedSegmentMB=85.77793312072754, floorSegmentMB=1.4532623291015625, forceMergeDeletesPctAllowed=15.105920411685705, segmentsPerTier=35.0, maxCFSSegmentSizeMB=8.796093022208E12, noCFSRatio=0.8191725363524409, deletesPctAllowed=42.31432712529108, targetSearchConcurrency=7
  2> 1022963 INFO  (coreLoadExecutor-16273-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
  2> 1022963 INFO  (coreLoadExecutor-16273-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
  2> 1022963 INFO  (coreLoadExecutor-16273-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=16777216, mergeFactor=16, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022208E12, noCFSRatio=0.8643451243232698]
  2> 1022994 INFO  (coreLoadExecutor-16273-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
  2> 1022994 INFO  (searcherExecutor-16275-thread-1-processing-collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
  2> 1022995 INFO  (searcherExecutor-16275-thread-1-processing-collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
  2> 1022995 INFO  (searcherExecutor-16275-thread-1-processing-collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: directMQF2
  2> 1022995 INFO  (searcherExecutor-16275-thread-1-processing-collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
  2> 1022995 INFO  (searcherExecutor-16275-thread-1-processing-collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
  2> 1022995 INFO  (searcherExecutor-16275-thread-1-processing-collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
  2> 1022995 INFO  (searcherExecutor-16275-thread-1-processing-collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
  2> 1022996 INFO  (searcherExecutor-16275-thread-1-processing-collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
  2> 1022996 INFO  (searcherExecutor-16275-thread-1-processing-collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
  2> 1022996 INFO  (searcherExecutor-16275-thread-1-processing-collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
  2> 1022997 INFO  (searcherExecutor-16275-thread-1-processing-collection1) [ x:collection1] o.a.s.c.SolrCore Registered new searcher autowarm time: 0 ms
  2> 1023039 INFO  (SUITE-TestFiltering-seed#[6D04FB0D4D019170]-worker) [] o.a.s.SolrTestCaseJ4 ####initCore end
  2> 1023043 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.SolrTestCaseJ4 ###Starting testRandomFiltering
  2> 1023043 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.DirectUpdateHandler2 REMOVING ALL DOCUMENTS FROM INDEX
  2> 1023043 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {deleteByQuery=*:*} 0 0
  2> 1023044 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[0]} 0 0
  2> 1023044 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[1]} 0 0
  2> 1023044 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[2]} 0 0
  2> 1023044 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[3]} 0 0
  2> 1023044 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[4]} 0 0
  2> 1023045 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[5]} 0 0
  2> 1023045 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[6]} 0 0
  2> 1023045 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[7]} 0 0
  2> 1023045 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[7]} 0 0
  2> 1023045 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[8]} 0 0
  2> 1023046 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[9]} 0 0
  2> 1023046 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[10]} 0 0
  2> 1023049 INFO  (searcherExecutor-16275-thread-1-processing-collection1) [ x:collection1] o.a.s.c.SolrCore Registered new searcher autowarm time: 0 ms
  2> 1023049 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory path=/update params={{params(wt=xml),defaults(wt=xml)}}{commit=} 0 2
  2> 1023050 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[11]} 0 0
  2> 1023050 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[12]} 0 0
  2> 1023050 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[13]} 0 0
  2> 1023051 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[14]} 0 0
  2> 1023051 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[15]} 0 0
  2> 1023051 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[16]} 0 0
  2> 1023051 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[16]} 0 0
  2> 1023051 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[17]} 0 0
  2> 1023051 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[18]} 0 0
  2> 1023052 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[19]} 0 0
  2> 1023052 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[20]} 0 0
  2> 1023052 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[21]} 0 0
  2> 1023052 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[21]} 0 0
  2> 1023052 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[22]} 0 0
  2> 1023052 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[23]} 0 0
  2> 1023053 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[23]} 0 0
  2> 1023053 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[24]} 0 0
  2> 1023053 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[24]} 0 0
  2> 1023053 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[25]} 0 0
  2> 1023053 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[26]} 0 0
  2> 1023053 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[27]} 0 0
  2> 1023054 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[28]} 0 0
  2> 1023054 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.u.p.LogUpdateProcessorFactory {add=[29]} 0 0
  2> 1023056 INFO  (searcherExecutor-16275-thread-1-processing-collection1) [ x:collection1] o.a.s.c.SolrCore Registered new searcher autowarm time: 0 ms
  2> 1023057 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory path=/update params={{params(wt=xml),defaults(wt=xml)}}{commit=} 0 2
  2> 1023057 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q=*:*&wt=xml} hits=30 status=0 QTime=0
  2> 1023064 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!cache%3Dfalse}+-val_i:0+-val_i:2+-val_i:6+-val_i:10+-val_i:11+-val_i:17+-val_i:19+-val_i:24+-val_i:28+-val_i:29&fq=val_s:{00009+TO+00035]+AND+val_s:[00010+TO+00036}&fq={!frange+v%3Dval_i+l%3D27+u%3D43}&fq={!+cache%3Dfalse+cost%3D170}val_i:{00020+TO+00045]+OR+val_i:[00021+TO+00046}&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+cache%3Dfalse}+val_i:1+val_i:3+val_i:4+val_i:5+val_i:8+val_i:9+val_i:11+val_i:12+val_i:14+val_i:16+val_i:20+val_i:21+val_i:26+val_i:28+val_i:29&wt=xml} hits=1 status=0 QTime=4
  2> 1023066 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!+cache%3Dtrue+tag%3Dt}-_query_:"val_i:{00005+TO+00030}"&fq={!+cache%3Dfalse+tag%3Dt}-_query_:"val_s:[00001+TO+00030}"&fq={!+cache%3Dfalse+tag%3Dt}id:RAND-925932592+OR+val_s:{00015+TO+00030}&wt=xml} hits=0 status=0 QTime=1
  2> 1023068 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q=-_query_:"val_i:[00003+TO+00029]"&fq={!+cache%3Dfalse+tag%3Dt}id:RAND-39467963+OR+val_s:{00005+TO+00032]&fq={!+cache%3Dfalse}val_s:{00021+TO+00042]+OR+val_s:[00022+TO+00043}&fq=-_query_:"{!frange+v%3Dval_i+l%3D16+u%3D29}"&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+cache%3Dfalse}+val_i:0+val_i:1+val_i:2+val_i:3+val_i:7+val_i:12+val_i:13+val_i:15+val_i:16+val_i:17+val_i:22+val_i:23+val_i:25+val_i:28+val_i:29&wt=xml} hits=0 status=0 QTime=1
  2> 1023070 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q=-_query_:"{!frange+v%3Dval_i+l%3D15+u%3D29}"&fq={!cache%3Dfalse}+val_i:3+val_i:4+val_i:8+val_i:10+val_i:16+val_i:19+val_i:24+val_i:25+val_i:28&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+cache%3Dfalse+cost%3D34}+val_i:1+val_i:3+val_i:4+val_i:7+val_i:10+val_i:11+val_i:16+val_i:22+val_i:23+val_i:25+val_i:26+val_i:27+val_i:28+val_i:29&group=true&group.main=true&group.field=id&group.cache.percent=100&wt=xml} hits=4 status=0 QTime=2
  2> 1023074 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!cache%3Dfalse+tag%3Dt}+val_i:1+val_i:2+val_i:3+val_i:4+val_i:6+val_i:9+val_i:10+val_i:12+val_i:14+val_i:15+val_i:16+val_i:17+val_i:19+val_i:20+val_i:22+val_i:23+val_i:27+val_i:28&fq={!+cache%3Dfalse+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D28+u%3D30}"&fq={!cache%3Dfalse+tag%3Dt}+val_i:0+val_i:1+val_i:2+val_i:3+val_i:4+val_i:7+val_i:9+val_i:10+val_i:12+val_i:13+val_i:23+val_i:24+val_i:28+val_i:29&fq={!+cache%3Dfalse+cost%3D107+tag%3Dt}-_query_:"val_i:{00016+TO+00029]"&wt=xml} hits=7 status=0 QTime=3
  2> 1023074 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!frange+v%3Dval_i+l%3D22+u%3D36+cache%3Dtrue+tag%3Dt}&fq={!frange+v%3Dval_i+l%3D8+u%3D28+cache%3Dfalse+cost%3D19+tag%3Dt}&wt=xml} hits=7 status=0 QTime=0
  2> 1023076 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!+cache%3Dtrue+tag%3Dt}-_query_:"val_s:[00002+TO+00029]"&fq=-_query_:"val_s:[00015+TO+00029]"&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery++cache%3Dfalse}-_query_:"val_s:[00023+TO+00029]"&wt=xml} hits=2 status=0 QTime=1
  2> 1023078 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!frange+v%3Dval_i+l%3D27+u%3D32+cache%3Dfalse+cost%3D91}&fq={!cache%3Dfalse+cost%3D154+tag%3Dt}+-val_i:0+-val_i:1+-val_i:2+-val_i:4+-val_i:6+-val_i:9+-val_i:10+-val_i:17+-val_i:21+-val_i:25+-val_i:27+-val_i:29&fq=+-val_i:0+-val_i:2+-val_i:3+-val_i:4+-val_i:5+-val_i:7+-val_i:8+-val_i:12+-val_i:13+-val_i:15+-val_i:17+-val_i:18+-val_i:19+-val_i:20+-val_i:22+-val_i:23+-val_i:26+-val_i:28&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+cache%3Dfalse}+val_i:1+val_i:4+val_i:5+val_i:7+val_i:8+val_i:10+val_i:11+val_i:14+val_i:15+val_i:17+val_i:19+val_i:21+val_i:24+val_i:25+val_i:27+val_i:29&wt=xml} hits=0 status=0 QTime=2
  2> 1023094 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!frange+v%3Dval_i+l%3D8+u%3D24}&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery}-_query_:"{!frange+v%3Dval_i+l%3D3+u%3D29}"&wt=xml} hits=17 status=0 QTime=0
  2> 1023096 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q=-_query_:"val_s:[00001+TO+00030}"&fq={!cache%3Dtrue+tag%3Dt}+-val_i:0+-val_i:1+-val_i:2+-val_i:6+-val_i:7+-val_i:9+-val_i:11+-val_i:12+-val_i:13+-val_i:16+-val_i:17+-val_i:18+-val_i:19+-val_i:21+-val_i:22+-val_i:24+-val_i:27+-val_i:28+-val_i:29&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+cache%3Dfalse}+val_i:0+val_i:5+val_i:6+val_i:7+val_i:11+val_i:13+val_i:14+val_i:15+val_i:16+val_i:17+val_i:18+val_i:19+val_i:21+val_i:27+val_i:28+val_i:29&wt=xml} hits=0 status=0 QTime=1
  2> 1023098 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!+cache%3Dtrue+tag%3Dt}-_query_:"val_i:[00002+TO+00030}"&fq={!frange+v%3Dval_i+l%3D4+u%3D31+cache%3Dfalse+tag%3Dt}&fq={!cache%3Dtrue+tag%3Dt}+-val_i:0+-val_i:2+-val_i:3+-val_i:4+-val_i:7+-val_i:8+-val_i:9+-val_i:11+-val_i:13+-val_i:16+-val_i:17+-val_i:23+-val_i:25+-val_i:26+-val_i:27+-val_i:29&fq={!frange+v%3Dval_i+l%3D24+u%3D47+cache%3Dfalse+tag%3Dt}&fq={!cache%3Dtrue+tag%3Dt}+-val_i:0+-val_i:1+-val_i:2+-val_i:4+-val_i:8+-val_i:9+-val_i:12+-val_i:13+-val_i:15+-val_i:16+-val_i:21+-val_i:24+-val_i:27+-val_i:29&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery}val_s:{00026+TO+00036}&wt=xml} hits=0 status=0 QTime=1
  2> 1023100 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!frange+v%3Dval_i+l%3D10+u%3D36}&fq=+val_i:0+val_i:5+val_i:7+val_i:10+val_i:11+val_i:13+val_i:14+val_i:16+val_i:18+val_i:19+val_i:20+val_i:21+val_i:22+val_i:23+val_i:24+val_i:25+val_i:26+val_i:27&fq={!+cache%3Dfalse+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D24+u%3D29}"&fq=-_query_:"{!frange+v%3Dval_i+l%3D19+u%3D29}"&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+}val_i:[00023+TO+00042]+OR+id:RAND-1524088295&wt=xml} hits=6 status=0 QTime=1
  2> 1023102 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!}val_i:{00016+TO+00047}+AND+val_i:[00017+TO+00046]&fq=-_query_:"{!frange+v%3Dval_i+l%3D20+u%3D29}"&fq=-_query_:"{!frange+v%3Dval_i+l%3D22+u%3D29}"&fq={!+cost%3D21}-_query_:"{!frange+v%3Dval_i+l%3D7+u%3D29}"&fq={!cache%3Dfalse+cost%3D145}+-val_i:1+-val_i:2+-val_i:5+-val_i:6+-val_i:12+-val_i:14+-val_i:16+-val_i:21+-val_i:24+-val_i:26&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery}-_query_:"{!frange+v%3Dval_i+l%3D6+u%3D29}"&wt=xml} hits=0 status=0 QTime=1
  2> 1023102 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!}-_query_:"val_i:{00022+TO+00030}"&wt=xml} hits=23 status=0 QTime=0
  2> 1023105 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!+cost%3D96+tag%3Dt}id:RAND1301491348+OR+val_s:{00012+TO+00041}&fq=-_query_:"{!frange+v%3Dval_i+l%3D15+u%3D29}"&fq={!cache%3Dtrue+tag%3Dt}+-val_i:0+-val_i:2+-val_i:3+-val_i:9+-val_i:14+-val_i:17+-val_i:19+-val_i:20+-val_i:21+-val_i:22+-val_i:26&fq=+-val_i:0+-val_i:1+-val_i:4+-val_i:8+-val_i:9+-val_i:11+-val_i:13+-val_i:15+-val_i:16+-val_i:17+-val_i:18+-val_i:19+-val_i:21+-val_i:23+-val_i:25+-val_i:27+-val_i:28&fq={!cache%3Dtrue+tag%3Dt}+val_i:1+val_i:2+val_i:4+val_i:5+val_i:7+val_i:9+val_i:11+val_i:14+val_i:15+val_i:16+val_i:17+val_i:23+val_i:26&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+cache%3Dfalse}+-val_i:0+-val_i:1+-val_i:3+-val_i:6+-val_i:8+-val_i:10+-val_i:12+-val_i:15+-val_i:16+-val_i:19+-val_i:20+-val_i:22+-val_i:23+-val_i:27+-val_i:28&wt=xml} hits=0 status=0 QTime=2
  2> 1023105 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!frange+v%3Dval_i+l%3D22+u%3D45+cache%3Dtrue+tag%3Dt}&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+frange+v%3Dval_i+l%3D13+u%3D39}&wt=xml} hits=8 status=0 QTime=0
  2> 1023106 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D3+u%3D29}"&fq={!+cache%3Dtrue+tag%3Dt}val_s:{00026+TO+00043]+OR+id:RAND-1853897678&fq={!frange+v%3Dval_i+l%3D19+u%3D25+cache%3Dfalse+cost%3D192}&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery}val_i:[00013+TO+00017]&wt=xml} hits=0 status=0 QTime=0
  2> 1023107 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q=-_query_:"{!frange+v%3Dval_i+l%3D4+u%3D29}"&fq={!cache%3Dfalse}+val_i:2+val_i:4+val_i:5+val_i:10+val_i:11+val_i:12+val_i:13+val_i:16+val_i:17+val_i:18+val_i:19+val_i:20+val_i:21+val_i:22+val_i:23+val_i:26+val_i:28&fq={!frange+v%3Dval_i+l%3D13+u%3D34+cache%3Dtrue+tag%3Dt}&wt=xml} hits=0 status=0 QTime=0
  2> 1023108 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q=-_query_:"val_s:{00022+TO+00030}"&fq={!+cache%3Dfalse}-_query_:"val_s:{00012+TO+00030}"&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+cache%3Dfalse+cost%3D52}+val_i:1+val_i:2+val_i:3+val_i:6+val_i:7+val_i:8+val_i:16+val_i:17+val_i:18+val_i:19+val_i:20+val_i:24+val_i:26&wt=xml} hits=13 status=0 QTime=1
  2> 1023112 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!cache%3Dtrue+tag%3Dt}+-val_i:0+-val_i:2+-val_i:3+-val_i:4+-val_i:10+-val_i:11+-val_i:13+-val_i:14+-val_i:16+-val_i:17+-val_i:20+-val_i:22+-val_i:23+-val_i:24+-val_i:25+-val_i:26+-val_i:27+-val_i:28+-val_i:29&fq={!cache%3Dfalse}+-val_i:0+-val_i:1+-val_i:2+-val_i:3+-val_i:7+-val_i:8+-val_i:10+-val_i:11+-val_i:12+-val_i:13+-val_i:18+-val_i:21+-val_i:23+-val_i:25&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D26+u%3D29}"&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery}+val_i:0+val_i:3+val_i:4+val_i:6+val_i:7+val_i:9+val_i:12+val_i:15+val_i:16+val_i:19+val_i:20+val_i:24+val_i:25+val_i:26+val_i:27+val_i:28+val_i:29&wt=xml} hits=5 status=0 QTime=3
  2> 1023114 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!cache%3Dfalse+cost%3D143+tag%3Dt}+val_i:1+val_i:2+val_i:3+val_i:5+val_i:7+val_i:9+val_i:10+val_i:11+val_i:12+val_i:14+val_i:16+val_i:19+val_i:20+val_i:22+val_i:24+val_i:26+val_i:27+val_i:28+val_i:29&fq={!+cache%3Dfalse}val_s:[00024+TO+00032}+AND+val_s:{00023+TO+00031]&fq=-_query_:"val_i:{00002+TO+00030}"&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery++cost%3D67}-_query_:"val_i:{00010+TO+00030}"&wt=xml} hits=0 status=0 QTime=1
  2> 1023115 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q=-_query_:"val_i:[00018+TO+00029]"&fq={!cache%3Dtrue}+val_i:0+val_i:1+val_i:2+val_i:3+val_i:4+val_i:5+val_i:6+val_i:11+val_i:17+val_i:20+val_i:21+val_i:22+val_i:23+val_i:24+val_i:28+val_i:29&fq=-_query_:"{!frange+v%3Dval_i+l%3D5+u%3D29}"&wt=xml} hits=5 status=0 QTime=0
  2> 1023117 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!cache%3Dfalse+cost%3D155+tag%3Dt}+val_i:3+val_i:4+val_i:5+val_i:11+val_i:13+val_i:14+val_i:15+val_i:20+val_i:21+val_i:23+val_i:24+val_i:25+val_i:29&fq={!frange+v%3Dval_i+l%3D11+u%3D34+cache%3Dtrue+tag%3Dt}&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery}+-val_i:1+-val_i:2+-val_i:5+-val_i:8+-val_i:11+-val_i:15+-val_i:18+-val_i:19+-val_i:20+-val_i:21+-val_i:22+-val_i:23+-val_i:24+-val_i:25+-val_i:26+-val_i:28&group=true&group.main=true&group.field=id&group.cache.percent=100&wt=xml} hits=10 status=0 QTime=2
  2> 1023118 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!+cache%3Dfalse+cost%3D115}*:*+AND+val_s:{00008+TO+00029}&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+}id:RAND-1831762486+OR+val_s:[00027+TO+00035]&wt=xml} hits=20 status=0 QTime=0
  2> 1023121 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!+cache%3Dfalse+cost%3D66}*:*+AND+val_i:{00000+TO+00030]&fq={!cache%3Dfalse+cost%3D74+tag%3Dt}+val_i:0+val_i:1+val_i:2+val_i:3+val_i:4+val_i:7+val_i:8+val_i:9+val_i:11+val_i:12+val_i:13+val_i:22+val_i:25+val_i:28+val_i:29&fq={!cache%3Dfalse}+val_i:0+val_i:3+val_i:4+val_i:6+val_i:7+val_i:8+val_i:9+val_i:11+val_i:15+val_i:16+val_i:19+val_i:20+val_i:25+val_i:27&fq=val_i:{00016+TO+00031]+AND+val_i:[00017+TO+00032}&fq={!cache%3Dfalse+cost%3D93+tag%3Dt}+val_i:0+val_i:1+val_i:5+val_i:6+val_i:9+val_i:12+val_i:16+val_i:25+val_i:26+val_i:28&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery}-_query_:"val_s:[00020+TO+00029]"&wt=xml} hits=1 status=0 QTime=2
  2> 1023122 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!cache%3Dtrue+tag%3Dt}+val_i:0+val_i:1+val_i:2+val_i:3+val_i:7+val_i:9+val_i:10+val_i:11+val_i:13+val_i:14+val_i:18+val_i:24+val_i:25+val_i:26+val_i:28&fq={!+cache%3Dfalse}val_i:[00003+TO+00032}&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+frange+v%3Dval_i+l%3D20+u%3D30+cost%3D156}&wt=xml} hits=12 status=0 QTime=1
  2> 1023125 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!cache%3Dtrue+tag%3Dt}+val_i:0+val_i:3+val_i:6+val_i:12+val_i:13+val_i:14+val_i:15+val_i:16+val_i:17+val_i:19+val_i:22+val_i:24+val_i:28+val_i:29&fq={!cache%3Dtrue}+-val_i:0+-val_i:2+-val_i:3+-val_i:4+-val_i:5+-val_i:6+-val_i:9+-val_i:10+-val_i:12+-val_i:14+-val_i:15+-val_i:16+-val_i:17+-val_i:20+-val_i:21+-val_i:23+-val_i:26+-val_i:27&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+cache%3Dfalse+cost%3D153}+-val_i:0+-val_i:4+-val_i:7+-val_i:8+-val_i:13+-val_i:16+-val_i:18+-val_i:20+-val_i:22+-val_i:23+-val_i:24+-val_i:29&wt=xml} hits=6 status=0 QTime=2
  2> 1023126 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!frange+v%3Dval_i+l%3D11+u%3D38+cache%3Dfalse}&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+cache%3Dfalse}+-val_i:1+-val_i:2+-val_i:3+-val_i:4+-val_i:6+-val_i:7+-val_i:8+-val_i:12+-val_i:15+-val_i:17+-val_i:18+-val_i:23+-val_i:25+-val_i:26&group=true&group.main=true&group.field=id&wt=xml} hits=19 status=0 QTime=1
  2> 1023128 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!cache%3Dtrue+tag%3Dt}+val_i:0+val_i:4+val_i:5+val_i:11+val_i:14+val_i:16+val_i:19+val_i:20+val_i:21+val_i:25+val_i:28+val_i:29&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"val_i:[00009+TO+00030}"&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery++cost%3D175}-_query_:"{!frange+v%3Dval_i+l%3D23+u%3D29}"&wt=xml} hits=3 status=0 QTime=1
  2> 1023130 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!+cache%3Dfalse+cost%3D159}id:RAND452818210+OR+val_i:[00011+TO+00036]&fq={!cache%3Dtrue}+-val_i:0+-val_i:1+-val_i:2+-val_i:4+-val_i:11+-val_i:13+-val_i:15+-val_i:17+-val_i:18+-val_i:19+-val_i:23+-val_i:24+-val_i:25+-val_i:27&fq={!+cache%3Dfalse+cost%3D133+tag%3Dt}-_query_:"val_i:[00028+TO+00029]"&fq={!+cache%3Dfalse}-_query_:"val_s:[00010+TO+00030}"&fq=+-val_i:1+-val_i:2+-val_i:5+-val_i:6+-val_i:7+-val_i:8+-val_i:9+-val_i:13+-val_i:14+-val_i:15+-val_i:19+-val_i:20+-val_i:21+-val_i:25+-val_i:28+-val_i:29&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery++cache%3Dfalse+cost%3D16}-_query_:"val_s:[00009+TO+00030}"&wt=xml} hits=0 status=0 QTime=2
  2> 1023131 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!+cache%3Dtrue+tag%3Dt}id:RAND-534261002+OR+val_i:[00020+TO+00047]&fq=+-val_i:1+-val_i:2+-val_i:3+-val_i:7+-val_i:9+-val_i:10+-val_i:12+-val_i:14+-val_i:19+-val_i:20+-val_i:21+-val_i:25&fq={!+cache%3Dfalse}-_query_:"{!frange+v%3Dval_i+l%3D14+u%3D29}"&fq={!frange+v%3Dval_i+l%3D0+u%3D20}&group=true&group.main=true&group.field=id&wt=xml} hits=0 status=0 QTime=1
  2> 1023133 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!+cache%3Dtrue+tag%3Dt}-_query_:"val_s:[00020+TO+00029]"&fq={!+cache%3Dfalse+tag%3Dt}-_query_:"val_i:{00001+TO+00030}"&fq={!cache%3Dtrue+tag%3Dt}+val_i:1+val_i:3+val_i:5+val_i:6+val_i:7+val_i:11+val_i:13+val_i:17+val_i:18+val_i:19+val_i:20+val_i:21+val_i:22+val_i:23+val_i:24+val_i:25&wt=xml} hits=1 status=0 QTime=1
  2> 1023134 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q=-_query_:"val_i:{00002+TO+00030}"&fq={!cache%3Dtrue+tag%3Dt}+val_i:1+val_i:2+val_i:8+val_i:9+val_i:10+val_i:12+val_i:13+val_i:14+val_i:15+val_i:16+val_i:17+val_i:19&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery}+val_i:1+val_i:2+val_i:3+val_i:4+val_i:5+val_i:8+val_i:9+val_i:10+val_i:11+val_i:13+val_i:14+val_i:17+val_i:18+val_i:20+val_i:22+val_i:28+val_i:29&wt=xml} hits=2 status=0 QTime=1
  2> 1023135 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!cache%3Dtrue+tag%3Dt}+val_i:0+val_i:1+val_i:2+val_i:3+val_i:6+val_i:8+val_i:16+val_i:19+val_i:21+val_i:23+val_i:24+val_i:25&fq={!+cache%3Dfalse+cost%3D66}-_query_:"{!frange+v%3Dval_i+l%3D5+u%3D29}"&wt=xml} hits=4 status=0 QTime=0
  2> 1023137 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!+cache%3Dtrue+tag%3Dt}val_s:[00014+TO+00038}&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"val_i:[00027+TO+00029]"&fq={!+cost%3D43+tag%3Dt}-_query_:"val_i:[00011+TO+00029]"&fq={!cache%3Dtrue}+-val_i:3+-val_i:4+-val_i:5+-val_i:6+-val_i:7+-val_i:10+-val_i:12+-val_i:19+-val_i:22+-val_i:23+-val_i:24&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+cache%3Dfalse+cost%3D23}+-val_i:0+-val_i:3+-val_i:4+-val_i:6+-val_i:7+-val_i:9+-val_i:12+-val_i:13+-val_i:14+-val_i:15+-val_i:19+-val_i:20+-val_i:22+-val_i:23+-val_i:25+-val_i:27+-val_i:28+-val_i:29&wt=xml} hits=0 status=0 QTime=1
  2> 1023138 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!+cost%3D168}val_s:{00028+TO+00029]&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery}+-val_i:2+-val_i:4+-val_i:5+-val_i:8+-val_i:11+-val_i:12+-val_i:15+-val_i:21+-val_i:22+-val_i:23+-val_i:24+-val_i:25+-val_i:27+-val_i:28&wt=xml} hits=1 status=0 QTime=0
  2> 1023138 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!+tag%3Dt}-_query_:"val_i:[00019+TO+00030}"&wt=xml} hits=19 status=0 QTime=0
  2> 1023140 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D7+u%3D29}"&fq={!cache%3Dfalse+tag%3Dt}+val_i:0+val_i:3+val_i:4+val_i:5+val_i:7+val_i:8+val_i:9+val_i:11+val_i:12+val_i:16+val_i:20+val_i:21+val_i:22+val_i:25+val_i:27+val_i:28+val_i:29&fq={!cache%3Dtrue+tag%3Dt}+-val_i:2+-val_i:3+-val_i:4+-val_i:5+-val_i:11+-val_i:12+-val_i:13+-val_i:14+-val_i:15+-val_i:16+-val_i:17+-val_i:19+-val_i:20+-val_i:21+-val_i:22+-val_i:23&fq={!+cache%3Dfalse+cost%3D193}-_query_:"{!frange+v%3Dval_i+l%3D4+u%3D29}"&fq={!+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D8+u%3D29}"&wt=xml} hits=1 status=0 QTime=1
  2> 1023142 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!+tag%3Dt}-_query_:"val_i:[00028+TO+00029]"&fq={!cache%3Dfalse+cost%3D9}+val_i:0+val_i:3+val_i:4+val_i:5+val_i:6+val_i:7+val_i:9+val_i:10+val_i:12+val_i:14+val_i:17+val_i:20+val_i:21+val_i:22+val_i:25+val_i:27+val_i:28+val_i:29&fq={!cache%3Dtrue+tag%3Dt}+-val_i:3+-val_i:5+-val_i:7+-val_i:10+-val_i:11+-val_i:13+-val_i:15+-val_i:16+-val_i:18+-val_i:19+-val_i:23+-val_i:25&fq={!frange+v%3Dval_i+l%3D10+u%3D38+cache%3Dtrue+tag%3Dt}&fq={!cache%3Dfalse+cost%3D130+tag%3Dt}+val_i:0+val_i:2+val_i:3+val_i:5+val_i:9+val_i:11+val_i:13+val_i:16+val_i:19+val_i:20+val_i:24+val_i:25+val_i:27+val_i:28&wt=xml} hits=2 status=0 QTime=1
  2> 1023143 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!cache%3Dfalse+tag%3Dt}+-val_i:2+-val_i:5+-val_i:6+-val_i:7+-val_i:10+-val_i:12+-val_i:13+-val_i:15+-val_i:16+-val_i:18+-val_i:19+-val_i:20+-val_i:23+-val_i:25+-val_i:28+-val_i:29&fq=val_i:[00026+TO+00049]+OR+id:RAND1799311574&wt=xml} hits=2 status=0 QTime=1
  2> 1023144 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!+cost%3D167+tag%3Dt}-_query_:"val_s:[00009+TO+00030}"&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+cache%3Dfalse+cost%3D108}+-val_i:0+-val_i:2+-val_i:3+-val_i:6+-val_i:7+-val_i:9+-val_i:10+-val_i:11+-val_i:13+-val_i:16+-val_i:17+-val_i:18+-val_i:22+-val_i:23+-val_i:26+-val_i:27+-val_i:28&wt=xml} hits=9 status=0 QTime=1
  2> 1023145 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!frange+v%3Dval_i+l%3D7+u%3D26+cache%3Dfalse+cost%3D57+tag%3Dt}&group=true&group.main=true&group.field=id&wt=xml} hits=20 status=0 QTime=0
  2> 1023146 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!cache%3Dtrue}+val_i:0+val_i:1+val_i:7+val_i:8+val_i:10+val_i:11+val_i:13+val_i:15+val_i:16+val_i:19+val_i:20+val_i:21+val_i:22+val_i:24+val_i:25+val_i:28+val_i:29&fq=-_query_:"{!frange+v%3Dval_i+l%3D1+u%3D29}"&fq={!+cache%3Dtrue+tag%3Dt}id:RAND-1009582730+OR+val_i:{00017+TO+00038}&fq={!cache%3Dfalse}+val_i:1+val_i:3+val_i:6+val_i:13+val_i:14+val_i:16+val_i:17+val_i:18+val_i:19+val_i:20+val_i:21+val_i:23+val_i:24+val_i:25+val_i:27+val_i:28+val_i:29&wt=xml} hits=0 status=0 QTime=0
  2> 1023148 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D8+u%3D29}"&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D11+u%3D29}"&fq={!frange+v%3Dval_i+l%3D26+u%3D30+cache%3Dfalse+cost%3D168}&fq=+-val_i:1+-val_i:4+-val_i:5+-val_i:7+-val_i:10+-val_i:12+-val_i:13+-val_i:14+-val_i:16+-val_i:18+-val_i:19+-val_i:20+-val_i:23+-val_i:27+-val_i:28+-val_i:29&wt=xml} hits=0 status=0 QTime=1
  2> 1023149 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q=+val_i:0+val_i:6+val_i:10+val_i:14+val_i:15+val_i:19+val_i:20+val_i:22+val_i:23+val_i:29&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+cache%3Dfalse}+val_i:0+val_i:1+val_i:2+val_i:3+val_i:4+val_i:9+val_i:11+val_i:12+val_i:15+val_i:16+val_i:19+val_i:23+val_i:26&wt=xml} hits=10 status=0 QTime=1
  2> 1023151 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!+cache%3Dfalse+tag%3Dt}val_i:[00025+TO+00044]&fq={!cache%3Dfalse+cost%3D129}+val_i:2+val_i:7+val_i:10+val_i:11+val_i:12+val_i:13+val_i:18+val_i:22+val_i:23+val_i:24+val_i:28&fq={!cache%3Dtrue}+-val_i:0+-val_i:2+-val_i:4+-val_i:5+-val_i:6+-val_i:7+-val_i:8+-val_i:10+-val_i:11+-val_i:12+-val_i:16+-val_i:18+-val_i:20+-val_i:23+-val_i:24+-val_i:27&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery++cost%3D38}val_i:{00009+TO+00035]+OR+id:RAND165627910&wt=xml} hits=1 status=0 QTime=1
  2> 1023152 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D27+u%3D29}"&fq={!+cache%3Dfalse+cost%3D190}-_query_:"val_i:{00009+TO+00030}"&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"val_i:{00004+TO+00029]"&fq=val_i:[00017+TO+00036}&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+cache%3Dfalse}+-val_i:1+-val_i:2+-val_i:4+-val_i:5+-val_i:6+-val_i:11+-val_i:12+-val_i:14+-val_i:15+-val_i:16+-val_i:17+-val_i:18+-val_i:20+-val_i:23+-val_i:24+-val_i:27+-val_i:29&wt=xml} hits=0 status=0 QTime=0
  2> 1023154 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!frange+v%3Dval_i+l%3D21+u%3D35+cache%3Dtrue+tag%3Dt}&fq=+val_i:0+val_i:4+val_i:10+val_i:12+val_i:14+val_i:15+val_i:20+val_i:21+val_i:22+val_i:23+val_i:25+val_i:26+val_i:27+val_i:29&fq={!cache%3Dfalse}+val_i:0+val_i:1+val_i:2+val_i:3+val_i:4+val_i:6+val_i:7+val_i:12+val_i:14+val_i:17+val_i:20+val_i:21+val_i:22&fq=+val_i:0+val_i:1+val_i:5+val_i:7+val_i:9+val_i:10+val_i:11+val_i:13+val_i:14+val_i:16+val_i:18+val_i:19+val_i:20+val_i:23+val_i:24+val_i:28+val_i:29&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery}-_query_:"val_s:{00011+TO+00030}"&wt=xml} hits=0 status=0 QTime=2
  2> 1023156 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!frange+v%3Dval_i+l%3D10+u%3D24+cost%3D117}&fq={!+tag%3Dt}val_i:[00023+TO+00043]+OR+val_i:{00022+TO+00044}&fq=+-val_i:5+-val_i:7+-val_i:8+-val_i:14+-val_i:15+-val_i:18+-val_i:19+-val_i:20+-val_i:22+-val_i:23+-val_i:24+-val_i:26+-val_i:27+-val_i:29&fq={!+cache%3Dfalse+cost%3D162}val_s:[00000+TO+00022]&wt=xml} hits=0 status=0 QTime=1
  2> 1023157 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!frange+v%3Dval_i+l%3D11+u%3D33}&fq={!cache%3Dfalse+cost%3D7+tag%3Dt}+val_i:5+val_i:6+val_i:8+val_i:10+val_i:12+val_i:13+val_i:19+val_i:27&fq={!+cache%3Dfalse+tag%3Dt}-_query_:"val_s:[00015+TO+00030}"&fq={!cache%3Dfalse+tag%3Dt}+val_i:0+val_i:1+val_i:2+val_i:4+val_i:5+val_i:6+val_i:8+val_i:11+val_i:15+val_i:16+val_i:18+val_i:20+val_i:23+val_i:24+val_i:25+val_i:26+val_i:27+val_i:28&fq={!+cost%3D96}val_s:{00025+TO+00046}+AND+val_s:[00026+TO+00045]&wt=xml} hits=0 status=0 QTime=1
  2> 1023160 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!cache%3Dfalse+tag%3Dt}+-val_i:3+-val_i:7+-val_i:10+-val_i:13+-val_i:14+-val_i:15+-val_i:21+-val_i:22+-val_i:27+-val_i:29&fq={!+cache%3Dfalse+cost%3D15+tag%3Dt}val_s:{00026+TO+00033]+OR+id:RAND833677013&fq={!cache%3Dfalse+cost%3D88}+val_i:0+val_i:2+val_i:5+val_i:9+val_i:11+val_i:12+val_i:15+val_i:17+val_i:18+val_i:21+val_i:22+val_i:24+val_i:25+val_i:26+val_i:27+val_i:29&fq={!cache%3Dtrue+tag%3Dt}+-val_i:0+-val_i:3+-val_i:8+-val_i:11+-val_i:14+-val_i:15+-val_i:17+-val_i:18+-val_i:27&fq={!+cache%3Dtrue+tag%3Dt}val_s:{00019+TO+00047}&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery}+val_i:4+val_i:7+val_i:8+val_i:12+val_i:13+val_i:14+val_i:19+val_i:21+val_i:23+val_i:26+val_i:27+val_i:29&wt=xml} hits=0 status=0 QTime=2
  2> 1023162 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!cache%3Dfalse+tag%3Dt}+val_i:0+val_i:2+val_i:3+val_i:4+val_i:6+val_i:11+val_i:13+val_i:14+val_i:16+val_i:17+val_i:18+val_i:24+val_i:25+val_i:26+val_i:28&fq={!cache%3Dfalse+cost%3D100}+-val_i:0+-val_i:2+-val_i:3+-val_i:4+-val_i:5+-val_i:6+-val_i:8+-val_i:9+-val_i:10+-val_i:11+-val_i:12+-val_i:14+-val_i:16+-val_i:18+-val_i:19+-val_i:21+-val_i:22+-val_i:23+-val_i:26+-val_i:28+-val_i:29&fq={!cache%3Dtrue}+val_i:0+val_i:2+val_i:4+val_i:6+val_i:12+val_i:19+val_i:22+val_i:25+val_i:27+val_i:28+val_i:29&wt=xml} hits=1 status=0 QTime=2
  2> 1023163 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!frange+v%3Dval_i+l%3D12+u%3D28+cache%3Dfalse+cost%3D119}&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery}+-val_i:0+-val_i:3+-val_i:4+-val_i:6+-val_i:7+-val_i:14+-val_i:15+-val_i:16+-val_i:17+-val_i:18+-val_i:21+-val_i:23+-val_i:26+-val_i:27+-val_i:28&wt=xml} hits=17 status=0 QTime=0
  2> 1023165 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D21+u%3D29}"&fq={!cache%3Dfalse}+val_i:1+val_i:4+val_i:5+val_i:7+val_i:9+val_i:10+val_i:13+val_i:14+val_i:15+val_i:17+val_i:19+val_i:20+val_i:22+val_i:27+val_i:29&fq={!frange+v%3Dval_i+l%3D23+u%3D41}&wt=xml} hits=0 status=0 QTime=1
  2> 1023166 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!cache%3Dtrue+tag%3Dt}+val_i:6+val_i:7+val_i:10+val_i:12+val_i:13+val_i:17+val_i:18+val_i:19+val_i:21+val_i:23+val_i:24+val_i:25+val_i:26+val_i:29&fq={!frange+v%3Dval_i+l%3D14+u%3D40+cache%3Dfalse+cost%3D6}&fq={!frange+v%3Dval_i+l%3D0+u%3D24}&fq={!frange+v%3Dval_i+l%3D17+u%3D33+cache%3Dtrue+tag%3Dt}&wt=xml} hits=6 status=0 QTime=1
  2> 1023167 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!+cache%3Dfalse+tag%3Dt}-_query_:"val_s:{00021+TO+00029]"&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"val_i:{00010+TO+00030}"&fq={!cache%3Dtrue+tag%3Dt}+val_i:0+val_i:2+val_i:3+val_i:5+val_i:6+val_i:7+val_i:11+val_i:12+val_i:13+val_i:14+val_i:15+val_i:19+val_i:20+val_i:25+val_i:27+val_i:28&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery}-_query_:"{!frange+v%3Dval_i+l%3D29+u%3D30}"&wt=xml} hits=6 status=0 QTime=1
  2> 1023168 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!frange+v%3Dval_i+l%3D17+u%3D22+cache%3Dfalse}&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"val_s:[00007+TO+00029]"&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+cache%3Dtrue}+val_i:0+val_i:2+val_i:3+val_i:7+val_i:12+val_i:16+val_i:19+val_i:23+val_i:24+val_i:26+val_i:27+val_i:29&wt=xml} hits=0 status=0 QTime=0
  2> 1023169 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!cache%3Dtrue}+val_i:1+val_i:3+val_i:6+val_i:10+val_i:14+val_i:22+val_i:23+val_i:24+val_i:25+val_i:27+val_i:28&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery}-_query_:"val_s:{00021+TO+00029]"&wt=xml} hits=11 status=0 QTime=0
  2> 1023170 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!frange+v%3Dval_i+l%3D28+u%3D38+cache%3Dtrue+tag%3Dt}&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+frange+v%3Dval_i+l%3D11+u%3D30+cache%3Dfalse+cost%3D28}&wt=xml} hits=2 status=0 QTime=0
  2> 1023172 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!cache%3Dfalse+cost%3D74+tag%3Dt}+-val_i:3+-val_i:6+-val_i:8+-val_i:9+-val_i:10+-val_i:11+-val_i:12+-val_i:13+-val_i:14+-val_i:15+-val_i:17+-val_i:21+-val_i:23+-val_i:24+-val_i:25+-val_i:28&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery}-_query_:"val_i:[00008+TO+00030}"&group=true&group.main=true&group.field=id&wt=xml} hits=14 status=0 QTime=1
  2> 1023174 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D0+u%3D29}"&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"val_s:[00018+TO+00029]"&fq={!cache%3Dfalse+tag%3Dt}+val_i:1+val_i:2+val_i:5+val_i:6+val_i:7+val_i:8+val_i:9+val_i:11+val_i:12+val_i:14+val_i:19+val_i:20+val_i:21+val_i:22+val_i:23+val_i:28+val_i:29&fq={!cache%3Dtrue+tag%3Dt}+val_i:0+val_i:4+val_i:5+val_i:10+val_i:12+val_i:13+val_i:14+val_i:17+val_i:18+val_i:19+val_i:21+val_i:22+val_i:25+val_i:26+val_i:29&fq={!cache%3Dfalse}+-val_i:3+-val_i:4+-val_i:6+-val_i:9+-val_i:11+-val_i:17+-val_i:19+-val_i:22+-val_i:23+-val_i:26+-val_i:28+-val_i:29&wt=xml} hits=0 status=0 QTime=2
  2> 1023175 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!+cache%3Dfalse+cost%3D35+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D11+u%3D29}"&fq={!+cache%3Dfalse+cost%3D24}-_query_:"val_s:{00026+TO+00029]"&fq={!frange+v%3Dval_i+l%3D22+u%3D28+cache%3Dtrue+tag%3Dt}&fq={!frange+v%3Dval_i+l%3D14+u%3D31+cache%3Dfalse}&wt=xml} hits=0 status=0 QTime=0
  2> 1023177 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!cache%3Dfalse+cost%3D139+tag%3Dt}+val_i:1+val_i:4+val_i:5+val_i:7+val_i:9+val_i:12+val_i:14+val_i:16+val_i:18+val_i:19+val_i:22+val_i:25+val_i:26+val_i:28&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D12+u%3D29}"&fq={!cache%3Dtrue+tag%3Dt}+-val_i:0+-val_i:1+-val_i:5+-val_i:6+-val_i:7+-val_i:10+-val_i:12+-val_i:13+-val_i:17+-val_i:20+-val_i:21+-val_i:22+-val_i:25+-val_i:27+-val_i:29&fq={!cache%3Dfalse+cost%3D128+tag%3Dt}+val_i:4+val_i:5+val_i:6+val_i:12+val_i:13+val_i:20+val_i:22+val_i:24+val_i:25+val_i:27&wt=xml} hits=1 status=0 QTime=1
  2> 1023178 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!frange+v%3Dval_i+l%3D15+u%3D36+cost%3D26}&fq={!cache%3Dtrue+tag%3Dt}+val_i:2+val_i:6+val_i:7+val_i:9+val_i:12+val_i:13+val_i:17+val_i:19+val_i:21+val_i:22+val_i:25+val_i:26&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+frange+v%3Dval_i+l%3D24+u%3D33}&wt=xml} hits=6 status=0 QTime=0
  2> 1023181 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!frange+v%3Dval_i+l%3D16+u%3D37+cache%3Dtrue+tag%3Dt}&fq={!cache%3Dfalse+tag%3Dt}+val_i:0+val_i:2+val_i:7+val_i:10+val_i:11+val_i:13+val_i:14+val_i:15+val_i:16+val_i:18+val_i:23+val_i:24+val_i:26+val_i:27&fq={!cache%3Dtrue}+val_i:6+val_i:8+val_i:10+val_i:12+val_i:13+val_i:15+val_i:16+val_i:17+val_i:19+val_i:20+val_i:22+val_i:24+val_i:25+val_i:28+val_i:29&fq={!cache%3Dtrue}+-val_i:0+-val_i:1+-val_i:4+-val_i:5+-val_i:6+-val_i:7+-val_i:9+-val_i:10+-val_i:11+-val_i:12+-val_i:17+-val_i:22+-val_i:24+-val_i:27+-val_i:28&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery++cache%3Dfalse+cost%3D167}-_query_:"{!frange+v%3Dval_i+l%3D12+u%3D29}"&wt=xml} hits=1 status=0 QTime=2
  2> 1023182 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!+cache%3Dtrue+tag%3Dt}-_query_:"val_s:{00021+TO+00029]"&fq={!+tag%3Dt}-_query_:"val_s:{00005+TO+00029]"&fq=+val_i:5+val_i:6+val_i:7+val_i:10+val_i:11+val_i:12+val_i:13+val_i:14+val_i:16+val_i:18+val_i:20+val_i:21+val_i:25+val_i:29&wt=xml} hits=1 status=0 QTime=1
  2> 1023183 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q=val_i:[00011+TO+00032]&fq={!+cost%3D83}-_query_:"val_i:{00010+TO+00030}"&fq={!+cache%3Dfalse+cost%3D158+tag%3Dt}-_query_:"val_i:[00005+TO+00030}"&fq={!cache%3Dtrue+tag%3Dt}+-val_i:0+-val_i:7+-val_i:9+-val_i:10+-val_i:11+-val_i:15+-val_i:16+-val_i:19+-val_i:22+-val_i:24+-val_i:25+-val_i:27+-val_i:28&wt=xml} hits=0 status=0 QTime=0
  2> 1023185 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q=+-val_i:1+-val_i:2+-val_i:3+-val_i:4+-val_i:5+-val_i:9+-val_i:10+-val_i:11+-val_i:15+-val_i:16+-val_i:17+-val_i:18+-val_i:19+-val_i:23&fq=-_query_:"{!frange+v%3Dval_i+l%3D20+u%3D29}"&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery+cache%3Dtrue}+val_i:0+val_i:1+val_i:3+val_i:5+val_i:6+val_i:7+val_i:8+val_i:9+val_i:11+val_i:12+val_i:13+val_i:19+val_i:20+val_i:21+val_i:22+val_i:24+val_i:25+val_i:26+val_i:27+val_i:28+val_i:29&wt=xml} hits=7 status=0 QTime=1
  2> 1023186 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!frange+v%3Dval_i+l%3D26+u%3D49+cache%3Dtrue+tag%3Dt}&fq=-_query_:"val_s:{00011+TO+00029]"&fq={!+cache%3Dfalse+cost%3D12}val_s:{00011+TO+00028}+OR+id:RAND1687134509&fq=-_query_:"{!frange+v%3Dval_i+l%3D12+u%3D29}"&wt=xml} hits=0 status=0 QTime=0
  2> 1023187 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!+cache%3Dtrue+tag%3Dt}val_s:[00027+TO+00032]&fq={!+cache%3Dtrue+tag%3Dt}val_i:[00015+TO+00034}&fq={!cache%3Dtrue+tag%3Dt}+-val_i:0+-val_i:2+-val_i:4+-val_i:5+-val_i:7+-val_i:9+-val_i:10+-val_i:11+-val_i:12+-val_i:14+-val_i:18+-val_i:20+-val_i:21+-val_i:23+-val_i:24+-val_i:27+-val_i:28+-val_i:29&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery++cache%3Dfalse}-_query_:"{!frange+v%3Dval_i+l%3D28+u%3D29}"&wt=xml} hits=0 status=0 QTime=1
  2> 1023188 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!+cache%3Dfalse+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D9+u%3D29}"&fq={!cache%3Dfalse}+val_i:0+val_i:1+val_i:2+val_i:4+val_i:5+val_i:9+val_i:10+val_i:18+val_i:20+val_i:24+val_i:26+val_i:28&wt=xml} hits=5 status=0 QTime=0
  2> 1023190 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!cache%3Dtrue}+val_i:1+val_i:5+val_i:6+val_i:8+val_i:9+val_i:10+val_i:12+val_i:14+val_i:16+val_i:17+val_i:19+val_i:21+val_i:23+val_i:24+val_i:25+val_i:26+val_i:28&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D25+u%3D29}"&fq={!+cost%3D32+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D11+u%3D29}"&wt=xml} hits=6 status=0 QTime=1
  2> 1023193 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!cache%3Dtrue}+val_i:2+val_i:10+val_i:11+val_i:12+val_i:17+val_i:18+val_i:23+val_i:24+val_i:25+val_i:26+val_i:27+val_i:29&fq={!cache%3Dfalse}+-val_i:5+-val_i:7+-val_i:9+-val_i:12+-val_i:13+-val_i:14+-val_i:16+-val_i:18+-val_i:23+-val_i:25+-val_i:26+-val_i:29&fq={!cache%3Dfalse+tag%3Dt}+-val_i:2+-val_i:3+-val_i:4+-val_i:5+-val_i:6+-val_i:8+-val_i:9+-val_i:11+-val_i:12+-val_i:15+-val_i:18+-val_i:19+-val_i:20+-val_i:21+-val_i:23+-val_i:24+-val_i:25+-val_i:27+-val_i:28+-val_i:29&fq={!cache%3Dtrue+tag%3Dt}+-val_i:1+-val_i:5+-val_i:7+-val_i:8+-val_i:9+-val_i:14+-val_i:18+-val_i:19+-val_i:21+-val_i:24+-val_i:25+-val_i:26+-val_i:29&wt=xml} hits=2 status=0 QTime=3
  2> 1023194 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!cache%3Dfalse+cost%3D133+tag%3Dt}+val_i:0+val_i:1+val_i:3+val_i:4+val_i:5+val_i:6+val_i:7+val_i:8+val_i:9+val_i:10+val_i:12+val_i:13+val_i:15+val_i:16+val_i:18+val_i:20+val_i:21+val_i:22+val_i:23+val_i:25+val_i:27+val_i:29&wt=xml} hits=22 status=0 QTime=0
  2> 1023196 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!cache%3Dtrue+tag%3Dt}+val_i:1+val_i:2+val_i:6+val_i:7+val_i:8+val_i:9+val_i:10+val_i:11+val_i:14+val_i:16+val_i:17+val_i:19+val_i:20+val_i:22+val_i:26+val_i:27+val_i:28&fq=+-val_i:0+-val_i:2+-val_i:3+-val_i:6+-val_i:8+-val_i:9+-val_i:10+-val_i:11+-val_i:13+-val_i:14+-val_i:18+-val_i:19+-val_i:20+-val_i:21+-val_i:24+-val_i:28&fq=-_query_:"{!frange+v%3Dval_i+l%3D25+u%3D29}"&fq={!+cache%3Dfalse+cost%3D82}-_query_:"val_s:{00013+TO+00030}"&fq={!+tag%3Dt}-_query_:"val_s:{00027+TO+00031}"&wt=xml} hits=2 status=0 QTime=2
  2> 1023198 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!+cache%3Dtrue+tag%3Dt}-_query_:"{!frange+v%3Dval_i+l%3D5+u%3D29}"&fq={!+cache%3Dtrue+tag%3Dt}-_query_:"val_i:[00010+TO+00030}"&fq={!cache%3Dfalse}+val_i:0+val_i:2+val_i:5+val_i:7+val_i:8+val_i:9+val_i:15+val_i:18+val_i:21+val_i:22+val_i:23+val_i:25+val_i:26+val_i:27+val_i:29&wt=xml} hits=2 status=0 QTime=1
  2> 1023200 INFO  (TEST-TestFiltering.testRandomFiltering-seed#[6D04FB0D4D019170]) [] o.a.s.c.S.Request path=null params={q={!cache%3Dfalse+tag%3Dt}+-val_i:1+-val_i:3+-val_i:4+-val_i:8+-val_i:10+-val_i:12+-val_i:17+-val_i:18+-val_i:20+-val_i:21+-val_i:25+-val_i:26+-val_i:27+-val_i:28+-val_i:29&fq=id:RAND569687683+OR+val_s:[00013+TO+00026]&fq={!frange+v%3Dval_i+l%3D8+u%3D29}&fq={!frange+v%3Dval_i+l%3D15+u%3D29+cache%3Dfalse}&facet=true&facet.query=*:*&facet.query={!key%3DmultiSelect+ex%3Dt}*:*&facet.query={!key%3DfacetQuery++cache%3Dfalse+cost%3D5}-_quer

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

nstantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
:solr:modules:scripting:test (SUCCESS): 24 test(s), 19 skipped

> Task :solr:modules:scripting:wipeTaskTemp
> Task :solr:modules:sql:compileTestJava
> Task :solr:modules:sql:testClasses

> Task :solr:modules:sql:test
WARNING: Using incubator modules: jdk.incubator.vector
WARNING: A command line option has enabled the Security Manager
WARNING: The Security Manager is deprecated and will be removed in a future release
WARNING: Using incubator modules: jdk.incubator.vector
WARNING: Using incubator modules: jdk.incubator.vector
WARNING: A command line option has enabled the Security Manager
WARNING: The Security Manager is deprecated and will be removed in a future release
WARNING: A command line option has enabled the Security Manager
WARNING: The Security Manager is deprecated and will be removed in a future release
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
java.security.policy: error adding Permission, java.net.URLPermission:
	java.util.ServiceConfigurationError: Locale provider adapter "CLDR"cannot be instantiated.
:solr:modules:sql:test (SUCCESS): 36 test(s)

> Task :checkWorkingCopyClean
> Task :solr:modules:sql:wipeTaskTemp
The slowest tests (exceeding 500 ms) during this run:
  65.70s TestCpuAllowedLimit.testDistribLimit (:solr:core)
  56.00s TestCpuAllowedLimit.testDistribLimit2 (:solr:core)
  47.00s TestRandomCollapseQParserPlugin.testRandomCollapseWithSort (:solr:core)
  44.02s TestInPlaceUpdatesDistrib.test (:solr:core)
  42.49s TestRandomFaceting.testRandomFaceting (:solr:core)
  40.14s HttpJettySolrClientTest.testIdleTimeoutWithHttpClient (:solr:solrj-jetty)
  39.93s PeerSyncReplicationTest.test (:solr:core)
  38.60s BasicDistributedZkTest.test (:solr:core)
  35.47s TestCloudSearcherWarming.testPeersyncFailureReplicationSuccess (:solr:core)
  32.89s ReindexCollectionTest.testSameTargetReindexing (:solr:core)
The slowest suites (exceeding 1s) during this run:
  130.83s TestCpuAllowedLimit (:solr:core)
  74.91s KnnQParserTest (:solr:core)
  68.37s TestRecovery (:solr:core)
  64.44s TestCoordinatorRole (:solr:core)
  64.05s ReindexCollectionTest (:solr:core)
  62.96s MultiThreadedOCPTest (:solr:core)
  58.33s TestTlogReplica (:solr:core)
  54.96s TestRandomCollapseQParserPlugin (:solr:core)
  53.91s CombinedQuerySolrCloudTest (:solr:core)
  51.36s HttpJettySolrClientTest (:solr:solrj-jetty)
ERROR: The following test(s) have failed:
  - org.apache.solr.search.TestFiltering.testRandomFiltering (:solr:core)
    Test history: https://develocity.apache.org/scans/tests?search.rootProjectNames=solr-root&tests.container=org.apache.solr.search.TestFiltering&tests.test=testRandomFiltering http://fucit.org/solr-jenkins-reports/history-trend-of-recent-failures.html#series/org.apache.solr.search.TestFiltering.testRandomFiltering
    Test output: /home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/solr/core/build/test-results/test/outputs/OUTPUT-org.apache.solr.search.TestFiltering.txt
    Reproduce with: ./gradlew :solr:core:test --tests "org.apache.solr.search.TestFiltering.testRandomFiltering" -Ptests.haltonfailure=false "-Ptests.jvmargs=-XX:TieredStopAtLevel=1 -XX:+UseParallelGC -XX:ActiveProcessorCount=1 -XX:ReservedCodeCacheSize=120m" -Ptests.seed=6D04FB0D4D019170 -Ptests.multiplier=2 -Ptests.useSecurityManager=true -Ptests.badapples=false -Ptests.file.encoding=US-ASCII


[Incubating] Problems report is available at: file:///home/jenkins/jenkins-agent/workspace/Solr/Solr-Test-10.x/build/reports/problems/problems-report.html

Deprecated Gradle features were used in this build, making it incompatible with Gradle 10.

You can use '--warning-mode all' to show the individual deprecation warnings and determine if they come from your own scripts or plugins.

For more on this, please refer to https://docs.gradle.org/9.7.0/userguide/command_line_interface.html#sec:command_line_warnings in the Gradle documentation.

BUILD SUCCESSFUL in 38m 13s
156 actionable tasks: 156 executed

Publishing Build Scan to Develocity...

The Develocity server (develocity.apache.org) rejected the credential with prefix '7x3jzizm4zpygv7psbkg6byvm4'.
Your credential has expired.

Build step 'Invoke Gradle script' changed build result to SUCCESS
Archiving artifacts
‘**/*.events’ doesn’t match anything: ‘**’ exists but not ‘**/*.events’
No artifacts found that match the file pattern "**/*.events,heapdumps/**,**/hs_err_pid*". Configuration error?
Recording test results
[Checks API] No suitable checks publisher found.
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)