You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2021/08/28 03:24:16 UTC
[JENKINS] Lucene » Lucene-Solr-Tests-8.x - Build # 3069 - Unstable!
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.x/3069/
2 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.handler.designer.TestSchemaDesignerAPI
Error Message:
Timed out waiting for all collections to be fully removed.
Stack Trace:
java.util.concurrent.TimeoutException: Timed out waiting for all collections to be fully removed.
at __randomizedtesting.SeedInfo.seed([F7C96A85EDC4EC48]:0)
at org.apache.solr.cloud.MiniSolrCloudCluster.deleteAllCollections(MiniSolrCloudCluster.java:581)
at org.apache.solr.handler.designer.TestSchemaDesignerAPI.tearDownCluster(TestSchemaDesignerAPI.java:82)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:901)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED: junit.framework.TestSuite.org.apache.solr.handler.designer.TestSchemaDesignerAPI
Error Message:
Captured an uncaught exception in thread: Thread[id=5770, name=Thread-686, state=RUNNABLE, group=TGRP-TestSchemaDesignerAPI]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=5770, name=Thread-686, state=RUNNABLE, group=TGRP-TestSchemaDesignerAPI]
Caused by: java.lang.AssertionError
at __randomizedtesting.SeedInfo.seed([F7C96A85EDC4EC48]:0)
at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1750)
at org.apache.solr.core.SolrCore.lambda$getConfListener$19(SolrCore.java:3147)
at org.apache.solr.cloud.ZkController.lambda$fireEventListeners$15(ZkController.java:2630)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 13899 lines...]
[junit4] Suite: org.apache.solr.handler.designer.TestSchemaDesignerAPI
[junit4] 2> 383137 INFO (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/server/solr/configsets/_default/conf'
[junit4] 2> 383138 INFO (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.designer.TestSchemaDesignerAPI_F7C96A85EDC4EC48-001/data-dir-97-001
[junit4] 2> 383138 INFO (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 383138 INFO (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 383138 INFO (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 383139 INFO (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.designer.TestSchemaDesignerAPI_F7C96A85EDC4EC48-001/tempDir-001
[junit4] 2> 383139 INFO (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 383140 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 383140 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 383141 WARN (ZkTestServer Run Thread) [ ] o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
[junit4] 2> 383240 INFO (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port: 33515
[junit4] 2> 383240 INFO (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:33515
[junit4] 2> 383240 INFO (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:33515
[junit4] 2> 383240 INFO (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 33515
[junit4] 2> 383242 INFO (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 383245 INFO (zkConnectionManagerCallback-3503-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 383245 INFO (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 383247 INFO (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 383249 INFO (zkConnectionManagerCallback-3505-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 383249 INFO (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 383251 INFO (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 383252 INFO (zkConnectionManagerCallback-3507-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 383252 INFO (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 383254 WARN (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker-SendThread(127.0.0.1:33515)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x100e41c9e4d0002.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x100e41c9e4d0002, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x100e41c9e4d0002, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 383356 INFO (jetty-launcher-3508-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 383356 INFO (jetty-launcher-3508-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 383356 INFO (jetty-launcher-3508-thread-1) [ ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
[junit4] 2> 383357 INFO (jetty-launcher-3508-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 383357 INFO (jetty-launcher-3508-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 383358 INFO (jetty-launcher-3508-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 383358 INFO (jetty-launcher-3508-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@28f1ea56{/solr,null,AVAILABLE}
[junit4] 2> 383358 INFO (jetty-launcher-3508-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@40f7a435{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:40407}
[junit4] 2> 383359 INFO (jetty-launcher-3508-thread-1) [ ] o.e.j.s.Server Started @383387ms
[junit4] 2> 383359 INFO (jetty-launcher-3508-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, zkHost=127.0.0.1:33515/solr, hostPort=40407}
[junit4] 2> 383359 ERROR (jetty-launcher-3508-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 383359 INFO (jetty-launcher-3508-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 383359 INFO (jetty-launcher-3508-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.10.0
[junit4] 2> 383359 INFO (jetty-launcher-3508-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 383359 INFO (jetty-launcher-3508-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
[junit4] 2> 383359 INFO (jetty-launcher-3508-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-08-28T02:28:28.565Z
[junit4] 2> 383360 INFO (jetty-launcher-3508-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 383361 INFO (zkConnectionManagerCallback-3510-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 383361 INFO (jetty-launcher-3508-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 383362 INFO (jetty-launcher-3508-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 383365 INFO (jetty-launcher-3508-thread-1) [ ] o.a.s.c.SolrXmlConfig Metrics collection is disabled.
[junit4] 2> 383366 WARN (jetty-launcher-3508-thread-1-SendThread(127.0.0.1:33515)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x100e41c9e4d0003.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x100e41c9e4d0003, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x100e41c9e4d0003, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 383850 INFO (jetty-launcher-3508-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 383851 WARN (jetty-launcher-3508-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@3e0011a1[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 383851 WARN (jetty-launcher-3508-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@3e0011a1[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 383857 WARN (jetty-launcher-3508-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@13d6b31a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 383857 WARN (jetty-launcher-3508-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@13d6b31a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 383858 INFO (jetty-launcher-3508-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33515/solr
[junit4] 2> 383859 INFO (jetty-launcher-3508-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 383861 INFO (zkConnectionManagerCallback-3521-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 383861 INFO (jetty-launcher-3508-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 383863 WARN (jetty-launcher-3508-thread-1-SendThread(127.0.0.1:33515)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x100e41c9e4d0004.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x100e41c9e4d0004, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x100e41c9e4d0004, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 383966 INFO (jetty-launcher-3508-thread-1) [n:127.0.0.1:40407_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 383976 INFO (zkConnectionManagerCallback-3523-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 383976 INFO (jetty-launcher-3508-thread-1) [n:127.0.0.1:40407_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 384179 WARN (jetty-launcher-3508-thread-1) [n:127.0.0.1:40407_solr ] o.a.s.c.ZkController Contents of zookeeper /security.json are world-readable; consider setting up ACLs as described in https://solr.apache.org/guide/zookeeper-access-control.html
[junit4] 2> 384191 INFO (jetty-launcher-3508-thread-1) [n:127.0.0.1:40407_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:40407_solr
[junit4] 2> 384191 INFO (jetty-launcher-3508-thread-1) [n:127.0.0.1:40407_solr ] o.a.s.c.Overseer Overseer (id=72308405603991557-127.0.0.1:40407_solr-n_0000000000) starting
[junit4] 2> 384198 INFO (OverseerStateUpdate-72308405603991557-127.0.0.1:40407_solr-n_0000000000) [n:127.0.0.1:40407_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:40407_solr
[junit4] 2> 384201 INFO (jetty-launcher-3508-thread-1) [n:127.0.0.1:40407_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:40407_solr
[junit4] 2> 384204 INFO (zkCallback-3522-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 384205 INFO (jetty-launcher-3508-thread-1) [n:127.0.0.1:40407_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 384206 WARN (jetty-launcher-3508-thread-1) [n:127.0.0.1:40407_solr ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 384236 INFO (jetty-launcher-3508-thread-1) [n:127.0.0.1:40407_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.designer.TestSchemaDesignerAPI_F7C96A85EDC4EC48-001/tempDir-001/node1
[junit4] 2> 384257 INFO (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker) [ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=1
[junit4] 2> 384258 INFO (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 384281 INFO (zkConnectionManagerCallback-3538-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 384281 INFO (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 384282 INFO (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 384283 INFO (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33515/solr ready
[junit4] 2> 384792 INFO (OverseerThreadFactory-3530-thread-1-processing-n:127.0.0.1:40407_solr) [n:127.0.0.1:40407_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection .system
[junit4] 2> 384908 INFO (OverseerStateUpdate-72308405603991557-127.0.0.1:40407_solr-n_0000000000) [n:127.0.0.1:40407_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:40407_solr",
[junit4] 2> "base_url":"http://127.0.0.1:40407/solr",
[junit4] 2> "collection":".system",
[junit4] 2> "shard":"shard1",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 385118 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr x:.system_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node2&collection.configName=.system&newCollection=true&name=.system_shard1_replica_n1&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 385119 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr x:.system_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 2147483647 cores with initial capacity of 1024
[junit4] 2> 385146 WARN (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SolrConfig You should not use LATEST as luceneMatchVersion property: if you use this setting, and then Solr upgrades to a newer release of Lucene, sizable changes may happen. If precise back compatibility is important then you should instead explicitly specify an actual Lucene version.
[junit4] 2> 385146 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.10.0
[junit4] 2> 385147 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed, but managed schema resource managed-schema not found - loading non-managed schema schema.xml instead
[junit4] 2> 385148 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema name=_system collection or core
[junit4] 2> 385149 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema _system collection or core/1.1 with uniqueid field id
[junit4] 2> 385153 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Created and persisted managed schema znode at /configs/.system/managed-schema
[junit4] 2> 385156 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema in ZooKeeper, renamed the non-managed schema /configs/.system/schema.xml to /configs/.system/schema.xml.bak
[junit4] 2> 385157 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore '.system_shard1_replica_n1' using configuration from configset .system, trusted=true
[junit4] 2> 385158 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SolrCore [[.system_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.designer.TestSchemaDesignerAPI_F7C96A85EDC4EC48-001/tempDir-001/node1/.system_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.designer.TestSchemaDesignerAPI_F7C96A85EDC4EC48-001/tempDir-001/node1/.system_shard1_replica_n1/data/]
[junit4] 2> 385358 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 385358 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 385359 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: if 1 uncommitted docs;
[junit4] 2> 385359 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 385362 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/.system
[junit4] 2> 385363 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/.system
[junit4] 2> 385363 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/.system/managed-schema
[junit4] 2> 385365 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 385365 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 385365 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1709302308479696896
[junit4] 2> 385371 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/.system/terms/shard1 to Terms{values={core_node2=0}, version=0}
[junit4] 2> 385371 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/.system/leaders/shard1
[junit4] 2> 385372 INFO (searcherExecutor-3540-thread-1-processing-n:127.0.0.1:40407_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node2) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SolrCore [.system_shard1_replica_n1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 385376 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 385376 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 385376 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:40407/solr/.system_shard1_replica_n1/
[junit4] 2> 385379 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 385379 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SyncStrategy http://127.0.0.1:40407/solr/.system_shard1_replica_n1/ has no replicas
[junit4] 2> 385379 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/.system/leaders/shard1/leader after winning as /collections/.system/leader_elect/shard1/election/72308405603991557-core_node2-n_0000000000
[junit4] 2> 385384 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:40407/solr/.system_shard1_replica_n1/ shard1
[junit4] 2> 385488 INFO (zkCallback-3522-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [1])
[junit4] 2> 385488 INFO (zkCallback-3522-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [1])
[junit4] 2> 385490 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 385496 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=.system&newCollection=true&name=.system_shard1_replica_n1&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=378
[junit4] 2> 385498 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 385625 INFO (zkCallback-3522-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [1])
[junit4] 2> 385625 INFO (zkCallback-3522-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [1])
[junit4] 2> 385625 INFO (zkCallback-3522-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [1])
[junit4] 2> 385627 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={pullReplicas=0&name=.system&nrtReplicas=1&action=CREATE&numShards=1&tlogReplicas=0&wt=javabin&version=2} status=0 QTime=1058
[junit4] 2> 385627 INFO (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker) [ ] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection: .system
[junit4] 2> 385652 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testSchemaDiffEndpoint
[junit4] 2> 386794 INFO (OverseerCollectionConfigSetProcessor-72308405603991557-127.0.0.1:40407_solr-n_0000000000) [n:127.0.0.1:40407_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 388776 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default to /configs/._designer_testDiff
[junit4] 2> 388779 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/protwords.txt to /configs/._designer_testDiff/protwords.txt
[junit4] 2> 388782 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/managed-schema to /configs/._designer_testDiff/managed-schema
[junit4] 2> 388785 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/solrconfig.xml to /configs/._designer_testDiff/solrconfig.xml
[junit4] 2> 388791 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_it.txt to /configs/._designer_testDiff/lang/contractions_it.txt
[junit4] 2> 388795 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_no.txt to /configs/._designer_testDiff/lang/stopwords_no.txt
[junit4] 2> 388801 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_ca.txt to /configs/._designer_testDiff/lang/contractions_ca.txt
[junit4] 2> 388803 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stemdict_nl.txt to /configs/._designer_testDiff/lang/stemdict_nl.txt
[junit4] 2> 388804 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hy.txt to /configs/._designer_testDiff/lang/stopwords_hy.txt
[junit4] 2> 388808 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_id.txt to /configs/._designer_testDiff/lang/stopwords_id.txt
[junit4] 2> 388814 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_et.txt to /configs/._designer_testDiff/lang/stopwords_et.txt
[junit4] 2> 388816 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ga.txt to /configs/._designer_testDiff/lang/stopwords_ga.txt
[junit4] 2> 388820 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_da.txt to /configs/._designer_testDiff/lang/stopwords_da.txt
[junit4] 2> 388822 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hi.txt to /configs/._designer_testDiff/lang/stopwords_hi.txt
[junit4] 2> 388825 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ja.txt to /configs/._designer_testDiff/lang/stopwords_ja.txt
[junit4] 2> 388827 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_pt.txt to /configs/._designer_testDiff/lang/stopwords_pt.txt
[junit4] 2> 388829 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hu.txt to /configs/._designer_testDiff/lang/stopwords_hu.txt
[junit4] 2> 388831 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_el.txt to /configs/._designer_testDiff/lang/stopwords_el.txt
[junit4] 2> 388836 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ru.txt to /configs/._designer_testDiff/lang/stopwords_ru.txt
[junit4] 2> 388840 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_tr.txt to /configs/._designer_testDiff/lang/stopwords_tr.txt
[junit4] 2> 388843 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ar.txt to /configs/._designer_testDiff/lang/stopwords_ar.txt
[junit4] 2> 388846 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/userdict_ja.txt to /configs/._designer_testDiff/lang/userdict_ja.txt
[junit4] 2> 388854 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_it.txt to /configs/._designer_testDiff/lang/stopwords_it.txt
[junit4] 2> 388858 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_eu.txt to /configs/._designer_testDiff/lang/stopwords_eu.txt
[junit4] 2> 388864 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_cz.txt to /configs/._designer_testDiff/lang/stopwords_cz.txt
[junit4] 2> 388869 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stoptags_ja.txt to /configs/._designer_testDiff/lang/stoptags_ja.txt
[junit4] 2> 388872 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_fr.txt to /configs/._designer_testDiff/lang/contractions_fr.txt
[junit4] 2> 388875 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_de.txt to /configs/._designer_testDiff/lang/stopwords_de.txt
[junit4] 2> 388878 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fa.txt to /configs/._designer_testDiff/lang/stopwords_fa.txt
[junit4] 2> 388880 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_ga.txt to /configs/._designer_testDiff/lang/contractions_ga.txt
[junit4] 2> 388882 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ca.txt to /configs/._designer_testDiff/lang/stopwords_ca.txt
[junit4] 2> 388886 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_nl.txt to /configs/._designer_testDiff/lang/stopwords_nl.txt
[junit4] 2> 388889 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_bg.txt to /configs/._designer_testDiff/lang/stopwords_bg.txt
[junit4] 2> 388893 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_en.txt to /configs/._designer_testDiff/lang/stopwords_en.txt
[junit4] 2> 388896 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_lv.txt to /configs/._designer_testDiff/lang/stopwords_lv.txt
[junit4] 2> 388904 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_es.txt to /configs/._designer_testDiff/lang/stopwords_es.txt
[junit4] 2> 388905 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_th.txt to /configs/._designer_testDiff/lang/stopwords_th.txt
[junit4] 2> 388907 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ro.txt to /configs/._designer_testDiff/lang/stopwords_ro.txt
[junit4] 2> 388911 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fr.txt to /configs/._designer_testDiff/lang/stopwords_fr.txt
[junit4] 2> 388914 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_sv.txt to /configs/._designer_testDiff/lang/stopwords_sv.txt
[junit4] 2> 388917 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fi.txt to /configs/._designer_testDiff/lang/stopwords_fi.txt
[junit4] 2> 388920 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/hyphenations_ga.txt to /configs/._designer_testDiff/lang/hyphenations_ga.txt
[junit4] 2> 388923 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_gl.txt to /configs/._designer_testDiff/lang/stopwords_gl.txt
[junit4] 2> 388925 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/synonyms.txt to /configs/._designer_testDiff/synonyms.txt
[junit4] 2> 388927 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/stopwords.txt to /configs/._designer_testDiff/stopwords.txt
[junit4] 2> 388936 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.10.0
[junit4] 2> 388936 WARN (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead
[junit4] 2> 388940 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.s.IndexSchema Schema name=default-config
[junit4] 2> 389919 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.s.IndexSchema Loaded schema default-config/1.6 with uniqueid field id
[junit4] 2> 390217 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.s.ManagedIndexSchema Persisted managed schema version 1 at /configs/._designer_testDiff/managed-schema
[junit4] 2> 390220 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 390223 INFO (zkConnectionManagerCallback-3549-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 390223 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 390230 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 390237 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33515/solr ready
[junit4] 2> 390248 INFO (OverseerThreadFactory-3530-thread-2-processing-n:127.0.0.1:40407_solr) [n:127.0.0.1:40407_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection ._designer_testDiff
[junit4] 2> 390381 INFO (OverseerStateUpdate-72308405603991557-127.0.0.1:40407_solr-n_0000000000) [n:127.0.0.1:40407_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "core":"._designer_testDiff_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:40407_solr",
[junit4] 2> "base_url":"http://127.0.0.1:40407/solr",
[junit4] 2> "collection":"._designer_testDiff",
[junit4] 2> "shard":"shard1",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 390588 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr x:._designer_testDiff_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node2&collection.configName=._designer_testDiff&newCollection=true&name=._designer_testDiff_shard1_replica_n1&action=CREATE&numShards=1&collection=._designer_testDiff&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 390621 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.10.0
[junit4] 2> 390621 WARN (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead
[junit4] 2> 390625 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema name=default-config
[junit4] 2> 390634 WARN (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.s.AbstractSpatialPrefixTreeFieldType FieldType SpatialRecursivePrefixTreeFieldType does not allow omitNorms to be specified in schema, hardcoded behavior is omitNorms=true
[junit4] 2> 390634 WARN (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.s.AbstractSpatialPrefixTreeFieldType FieldType SpatialRecursivePrefixTreeFieldType does not allow omitTermFreqAndPositions to be specified in schema, hardcoded behavior is omitTermFreqAndPositions=true
[junit4] 2> 390634 WARN (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.s.AbstractSpatialPrefixTreeFieldType FieldType SpatialRecursivePrefixTreeFieldType does not allow termOffsets to be specified in schema, hardcoded behavior is termOffsets=false
[junit4] 2> 390634 WARN (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.s.AbstractSpatialPrefixTreeFieldType FieldType SpatialRecursivePrefixTreeFieldType does not allow termPositions to be specified in schema, hardcoded behavior is termPositions=false
[junit4] 2> 390634 WARN (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.s.AbstractSpatialPrefixTreeFieldType FieldType SpatialRecursivePrefixTreeFieldType does not allow omitPositions to be specified in schema, hardcoded behavior is omitPositions=true
[junit4] 2> 390675 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema default-config/1.6 with uniqueid field id
[junit4] 2> 391043 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore '._designer_testDiff_shard1_replica_n1' using configuration from configset ._designer_testDiff, trusted=true
[junit4] 2> 391043 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.c.SolrCore [[._designer_testDiff_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.designer.TestSchemaDesignerAPI_F7C96A85EDC4EC48-001/tempDir-001/node1/._designer_testDiff_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.designer.TestSchemaDesignerAPI_F7C96A85EDC4EC48-001/tempDir-001/node1/._designer_testDiff_shard1_replica_n1/data/]
[junit4] 2> 391138 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 391138 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 391142 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: if uncommitted for 15000ms;
[junit4] 2> 391142 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 391151 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/._designer_testDiff
[junit4] 2> 391155 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/._designer_testDiff
[junit4] 2> 391155 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/._designer_testDiff/managed-schema
[junit4] 2> 391159 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Current schema version 1 is already the latest
[junit4] 2> 391159 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 391159 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.s.DirectSolrSpellChecker init: {name=default,field=_text_,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxQueryFrequency=0.01,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4}
[junit4] 2> 391161 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 391162 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1709302314558291968
[junit4] 2> 391166 INFO (searcherExecutor-3551-thread-1-processing-n:127.0.0.1:40407_solr x:._designer_testDiff_shard1_replica_n1 c:._designer_testDiff s:shard1 r:core_node2) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 391166 INFO (searcherExecutor-3551-thread-1-processing-n:127.0.0.1:40407_solr x:._designer_testDiff_shard1_replica_n1 c:._designer_testDiff s:shard1 r:core_node2) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 391166 INFO (searcherExecutor-3551-thread-1-processing-n:127.0.0.1:40407_solr x:._designer_testDiff_shard1_replica_n1 c:._designer_testDiff s:shard1 r:core_node2) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.c.SolrCore [._designer_testDiff_shard1_replica_n1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 391183 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/._designer_testDiff/terms/shard1 to Terms{values={core_node2=0}, version=0}
[junit4] 2> 391183 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/._designer_testDiff/leaders/shard1
[junit4] 2> 391201 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 391201 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 391201 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:40407/solr/._designer_testDiff_shard1_replica_n1/
[junit4] 2> 391203 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 391205 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.c.SyncStrategy http://127.0.0.1:40407/solr/._designer_testDiff_shard1_replica_n1/ has no replicas
[junit4] 2> 391206 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/._designer_testDiff/leaders/shard1/leader after winning as /collections/._designer_testDiff/leader_elect/shard1/election/72308405603991557-core_node2-n_0000000000
[junit4] 2> 391216 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:40407/solr/._designer_testDiff_shard1_replica_n1/ shard1
[junit4] 2> 391318 INFO (zkCallback-3522-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/._designer_testDiff/state.json] for collection [._designer_testDiff] has occurred - updating... (live nodes size: [1])
[junit4] 2> 391318 INFO (zkCallback-3522-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/._designer_testDiff/state.json] for collection [._designer_testDiff] has occurred - updating... (live nodes size: [1])
[junit4] 2> 391319 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr c:._designer_testDiff s:shard1 r:core_node2 x:._designer_testDiff_shard1_replica_n1 ] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 391323 INFO (qtp1311789955-5506) [n:127.0.0.1:40407_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=._designer_testDiff&newCollection=true&name=._designer_testDiff_shard1_replica_n1&action=CREATE&numShards=1&collection=._designer_testDiff&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=734
[junit4] 2> 391325 INFO (qtp1311789955-5508) [n:127.0.0.1:40407_solr ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 391558 INFO (zkCallback-3522-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/._designer_testDiff/state.json] for collection [._designer_testDiff] has occurred - updating... (live nodes size: [1])
[junit4] 2> 391558 INFO (zkCallback-3522-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/._designer_testDiff/state.json] for collection [._designer_testDiff] has occurred - updating... (live nodes size: [1])
[junit4] 2> 391558 INFO (zkCallback-3522-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/._designer_testDiff/state.json] for collection [._designer_testDiff] has occurred - updating... (live nodes size: [1])
[junit4] 2> 391561 INFO (qtp1311789955-5508) [n:127.0.0.1:40407_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=._designer_testDiff&maxShardsPerNode=-1&name=._designer_testDiff&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2} status=0 QTime=1322
[junit4] 2> 391561 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 391579 INFO (Thread-666) [ ] o.a.s.c.SolrCore config update listener called for core ._designer_testDiff_shard1_replica_n1
[junit4] 2> 391581 INFO (Thread-666) [n:127.0.0.1:40407_solr ] o.a.s.c.SolrCore core reload ._designer_testDiff_shard1_replica_n1
[junit4] 2> 391589 INFO (Thread-666) [n:127.0.0.1:40407_solr ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.10.0
[junit4] 2> 391589 WARN (Thread-666) [n:127.0.0.1:40407_solr ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead
[junit4] 2> 391590 INFO (Thread-666) [n:127.0.0.1:40407_solr ] o.a.s.s.IndexSchema Schema name=default-config
[junit4] 2> 391594 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.10.0
[junit4] 2> 391595 WARN (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead
[junit4] 2> 391595 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff to /configs/testDiff
[junit4] 2> 391596 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/protwords.txt to /configs/testDiff/protwords.txt
[junit4] 2> 391597 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/managed-schema to /configs/testDiff/managed-schema
[junit4] 2> 391599 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/solrconfig.xml to /configs/testDiff/solrconfig.xml
[junit4] 2> 391600 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/synonyms.txt to /configs/testDiff/synonyms.txt
[junit4] 2> 391601 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/configoverlay.json to /configs/testDiff/configoverlay.json
[junit4] 2> 391603 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/stopwords.txt to /configs/testDiff/stopwords.txt
[junit4] 2> 391604 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/contractions_it.txt to /configs/testDiff/lang/contractions_it.txt
[junit4] 2> 391605 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_no.txt to /configs/testDiff/lang/stopwords_no.txt
[junit4] 2> 391608 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/contractions_ca.txt to /configs/testDiff/lang/contractions_ca.txt
[junit4] 2> 391609 WARN (Thread-666) [n:127.0.0.1:40407_solr ] o.a.s.s.AbstractSpatialPrefixTreeFieldType FieldType SpatialRecursivePrefixTreeFieldType does not allow omitNorms to be specified in schema, hardcoded behavior is omitNorms=true
[junit4] 2> 391609 WARN (Thread-666) [n:127.0.0.1:40407_solr ] o.a.s.s.AbstractSpatialPrefixTreeFieldType FieldType SpatialRecursivePrefixTreeFieldType does not allow omitTermFreqAndPositions to be specified in schema, hardcoded behavior is omitTermFreqAndPositions=true
[junit4] 2> 391609 WARN (Thread-666) [n:127.0.0.1:40407_solr ] o.a.s.s.AbstractSpatialPrefixTreeFieldType FieldType SpatialRecursivePrefixTreeFieldType does not allow termOffsets to be specified in schema, hardcoded behavior is termOffsets=false
[junit4] 2> 391609 WARN (Thread-666) [n:127.0.0.1:40407_solr ] o.a.s.s.AbstractSpatialPrefixTreeFieldType FieldType SpatialRecursivePrefixTreeFieldType does not allow termPositions to be specified in schema, hardcoded behavior is termPositions=false
[junit4] 2> 391609 WARN (Thread-666) [n:127.0.0.1:40407_solr ] o.a.s.s.AbstractSpatialPrefixTreeFieldType FieldType SpatialRecursivePrefixTreeFieldType does not allow omitPositions to be specified in schema, hardcoded behavior is omitPositions=true
[junit4] 2> 391609 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stemdict_nl.txt to /configs/testDiff/lang/stemdict_nl.txt
[junit4] 2> 391613 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_hy.txt to /configs/testDiff/lang/stopwords_hy.txt
[junit4] 2> 391617 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_id.txt to /configs/testDiff/lang/stopwords_id.txt
[junit4] 2> 391621 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_et.txt to /configs/testDiff/lang/stopwords_et.txt
[junit4] 2> 391622 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_ga.txt to /configs/testDiff/lang/stopwords_ga.txt
[junit4] 2> 391624 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_da.txt to /configs/testDiff/lang/stopwords_da.txt
[junit4] 2> 391634 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_hi.txt to /configs/testDiff/lang/stopwords_hi.txt
[junit4] 2> 391636 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_ja.txt to /configs/testDiff/lang/stopwords_ja.txt
[junit4] 2> 391639 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_pt.txt to /configs/testDiff/lang/stopwords_pt.txt
[junit4] 2> 391641 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_hu.txt to /configs/testDiff/lang/stopwords_hu.txt
[junit4] 2> 391642 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_el.txt to /configs/testDiff/lang/stopwords_el.txt
[junit4] 2> 391645 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_ru.txt to /configs/testDiff/lang/stopwords_ru.txt
[junit4] 2> 391654 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_tr.txt to /configs/testDiff/lang/stopwords_tr.txt
[junit4] 2> 391656 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_ar.txt to /configs/testDiff/lang/stopwords_ar.txt
[junit4] 2> 391658 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/userdict_ja.txt to /configs/testDiff/lang/userdict_ja.txt
[junit4] 2> 391660 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_it.txt to /configs/testDiff/lang/stopwords_it.txt
[junit4] 2> 391663 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_eu.txt to /configs/testDiff/lang/stopwords_eu.txt
[junit4] 2> 391665 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_cz.txt to /configs/testDiff/lang/stopwords_cz.txt
[junit4] 2> 391668 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stoptags_ja.txt to /configs/testDiff/lang/stoptags_ja.txt
[junit4] 2> 391671 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/contractions_fr.txt to /configs/testDiff/lang/contractions_fr.txt
[junit4] 2> 391673 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_de.txt to /configs/testDiff/lang/stopwords_de.txt
[junit4] 2> 391675 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_fa.txt to /configs/testDiff/lang/stopwords_fa.txt
[junit4] 2> 391678 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/contractions_ga.txt to /configs/testDiff/lang/contractions_ga.txt
[junit4] 2> 391680 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_ca.txt to /configs/testDiff/lang/stopwords_ca.txt
[junit4] 2> 391685 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_nl.txt to /configs/testDiff/lang/stopwords_nl.txt
[junit4] 2> 391688 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_bg.txt to /configs/testDiff/lang/stopwords_bg.txt
[junit4] 2> 391691 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_en.txt to /configs/testDiff/lang/stopwords_en.txt
[junit4] 2> 391694 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_lv.txt to /configs/testDiff/lang/stopwords_lv.txt
[junit4] 2> 391696 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_es.txt to /configs/testDiff/lang/stopwords_es.txt
[junit4] 2> 391699 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_th.txt to /configs/testDiff/lang/stopwords_th.txt
[junit4] 2> 391701 INFO (Thread-666) [n:127.0.0.1:40407_solr ] o.a.s.s.IndexSchema Loaded schema default-config/1.6 with uniqueid field id
[junit4] 2> 391701 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_ro.txt to /configs/testDiff/lang/stopwords_ro.txt
[junit4] 2> 391703 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_fr.txt to /configs/testDiff/lang/stopwords_fr.txt
[junit4] 2> 391705 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_sv.txt to /configs/testDiff/lang/stopwords_sv.txt
[junit4] 2> 391707 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_fi.txt to /configs/testDiff/lang/stopwords_fi.txt
[junit4] 2> 391721 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/hyphenations_ga.txt to /configs/testDiff/lang/hyphenations_ga.txt
[junit4] 2> 391725 INFO (TEST-TestSchemaDesignerAPI.testSchemaDiffEndpoint-seed#[F7C96A85EDC4EC48]) [ ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/._designer_testDiff/lang/stopwords_gl.txt to /configs/testDiff/lang/stopwords_gl.txt
[junit4] 2> 391738 INFO (OverseerThreadFactory-3530-thread-3-processing-n:127.0.0.1:40407_solr) [n:127.0.0.1:40407_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection diff456
[junit4] 2> 391738 INFO (OverseerCollectionConfigSetProcessor-72308405603991557-127.0.0.1:40407_solr-n_0000000000) [n:127.0.0.1:40407_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 391844 INFO (Thread-666) [n:127.0.0.1:40407_solr ] o.a.s.c.CoreContainer Reloading SolrCore '._designer_testDiff_shard1_replica_n1' using configuration from configset ._designer_testDiff
[junit4] 2> 391845 INFO (Thread-666) [n:127.0.0.1:40407_solr ] o.a.s.c.SolrCore [[._designer_testDiff_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.designer.TestSchemaDesignerAPI_F7C96A85EDC4EC48-001/tempDir-001/node1/._designer_testDiff_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.designer.TestSchemaDesignerAPI_F7C96A85EDC4EC48-001/tempDir-001/node1/._designer_testDiff_shard1_replica_n1/data/]
[junit4] 2> 391904 INFO (Thread-666) [n:127.0.0.1:40407_solr ] o.a.s.u.CommitTracker Hard AutoCommit: if uncommitted for 15000ms;
[junit4] 2> 391904 INFO (Thread-666) [n:127.0.0.1:40407_solr ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 391909 INFO (Thread-666) [n:127.0.0.1:40407_solr ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/._designer_testDiff
[junit4] 2> 391911 INFO (Thread-666) [n:127.0.0.1:40407_solr ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/._designer_testDiff
[junit4] 2> 391911 INFO (Thread-666) [n:127.0.0.1:40407_solr ] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/._designer_testDiff/managed-schema
[junit4] 2> 391911 INFO (Thread-666) [n:127.0.0.1:40407_solr ] o.a.s.s.ZkIndexSchemaReader Current schema version 1 is already the latest
[junit4] 2> 391911 INFO (Thread-666) [n:127.0.0.1:40407_solr ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 391911 INFO (Thread-666) [n:127.0.0.1:40407_solr ] o.a.s.s.DirectSolrSpellChecker init: {name=default,field=_text_,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxQueryFrequency=0.01,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4}
[junit4] 2> 391914 INFO (Thread-666) [n:127.0.0.1:40407_solr ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 391915 INFO (Thread-666) [n:127.0.0.1:40407_solr ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1709302315347869696
[junit4] 2> 391916 INFO (searcherExecutor-3557-thread-1-processing-n:127.0.0.1:40407_solr) [n:127.0.0.1:40407_solr ] o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 391916 INFO (searcherExecutor-3557-thread-1-processing-n:127.0.0.1:40407_solr) [n:127.0.0.1:40407_solr ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 391916 INFO (searcherExecutor-3557-thread-1-processing-n:127.0.0.1:40407_solr) [n:127.0.0.1:40407_solr ] o.a.s.c.SolrCore [._designer_testDiff_shard1_replica_n1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 391919 INFO (Thread-666) [n:127.0.0.1:40407_solr ] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 391919 INFO (Thread-666) [n:127.0.0.1:40407_solr ] o.a.s.c.SolrCore [._designer_testDiff_shard1_replica_n1] CLOSING SolrCore org.apache.solr.core.SolrCore@5860cd15
[junit4] 2> 391919 INFO (Thread-666) [n:127.0.0.1:40407_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.._designer_testDiff.shard1.replica_n1 tag=SolrCore@5860cd15
[junit4] 2> 391919 INFO (Thread-666) [n:127.0.0.1:40407_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.._designer_testDiff.shard1.leader tag=SolrCore@5860cd15
[junit4] 2> 391922 INFO (searcherExecutor-3557-thread-1-processing-n:127.0.0.1:40407_solr) [n:127.0.0.1:40407_solr ] o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 391922 INFO (searcherExecutor-3557-thread-1-processing-n:127.0.0.1:40407_solr) [n:127.0.0.1:40407_solr ] o.a.s.c.SolrCore [._designer_testDiff_shard1_replica_n1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 391959 INFO (OverseerStateUpdate-72308405603991557-127.0.0.1:40407_solr-n_0000000000) [n:127.0.0.1:40407_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "core":"diff456_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:40407_solr",
[junit4] 2> "base_url":"http://127.0.0.1:40407/solr",
[junit4] 2> "collection":"diff456",
[junit4] 2> "shard":"shard1",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 392161 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr x:diff456_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node2&collection.configName=testDiff&newCollection=true&name=diff456_shard1_replica_n1&action=CREATE&numShards=1&collection=diff456&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 392175 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.10.0
[junit4] 2> 392175 WARN (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead
[junit4] 2> 392178 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema name=default-config
[junit4] 2> 392185 WARN (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.s.AbstractSpatialPrefixTreeFieldType FieldType SpatialRecursivePrefixTreeFieldType does not allow omitNorms to be specified in schema, hardcoded behavior is omitNorms=true
[junit4] 2> 392185 WARN (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.s.AbstractSpatialPrefixTreeFieldType FieldType SpatialRecursivePrefixTreeFieldType does not allow omitTermFreqAndPositions to be specified in schema, hardcoded behavior is omitTermFreqAndPositions=true
[junit4] 2> 392185 WARN (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.s.AbstractSpatialPrefixTreeFieldType FieldType SpatialRecursivePrefixTreeFieldType does not allow termOffsets to be specified in schema, hardcoded behavior is termOffsets=false
[junit4] 2> 392185 WARN (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.s.AbstractSpatialPrefixTreeFieldType FieldType SpatialRecursivePrefixTreeFieldType does not allow termPositions to be specified in schema, hardcoded behavior is termPositions=false
[junit4] 2> 392186 WARN (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.s.AbstractSpatialPrefixTreeFieldType FieldType SpatialRecursivePrefixTreeFieldType does not allow omitPositions to be specified in schema, hardcoded behavior is omitPositions=true
[junit4] 2> 392241 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema default-config/1.6 with uniqueid field id
[junit4] 2> 392300 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore 'diff456_shard1_replica_n1' using configuration from configset testDiff, trusted=true
[junit4] 2> 392301 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.c.SolrCore [[diff456_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.designer.TestSchemaDesignerAPI_F7C96A85EDC4EC48-001/tempDir-001/node1/diff456_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.designer.TestSchemaDesignerAPI_F7C96A85EDC4EC48-001/tempDir-001/node1/diff456_shard1_replica_n1/data/]
[junit4] 2> 392337 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 392337 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 392338 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: if uncommitted for 15000ms;
[junit4] 2> 392338 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 392340 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/testDiff
[junit4] 2> 392341 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/testDiff
[junit4] 2> 392341 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/testDiff/managed-schema
[junit4] 2> 392342 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 392342 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 392342 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.s.DirectSolrSpellChecker init: {name=default,field=_text_,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxQueryFrequency=0.01,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4}
[junit4] 2> 392342 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 392343 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1709302315796660224
[junit4] 2> 392345 INFO (searcherExecutor-3562-thread-1-processing-n:127.0.0.1:40407_solr x:diff456_shard1_replica_n1 c:diff456 s:shard1 r:core_node2) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 392345 INFO (searcherExecutor-3562-thread-1-processing-n:127.0.0.1:40407_solr x:diff456_shard1_replica_n1 c:diff456 s:shard1 r:core_node2) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 392345 INFO (searcherExecutor-3562-thread-1-processing-n:127.0.0.1:40407_solr x:diff456_shard1_replica_n1 c:diff456 s:shard1 r:core_node2) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.c.SolrCore [diff456_shard1_replica_n1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 392352 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/diff456/terms/shard1 to Terms{values={core_node2=0}, version=0}
[junit4] 2> 392352 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/diff456/leaders/shard1
[junit4] 2> 392360 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 392360 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 392360 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:40407/solr/diff456_shard1_replica_n1/
[junit4] 2> 392361 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 392363 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.c.SyncStrategy http://127.0.0.1:40407/solr/diff456_shard1_replica_n1/ has no replicas
[junit4] 2> 392363 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/diff456/leaders/shard1/leader after winning as /collections/diff456/leader_elect/shard1/election/72308405603991557-core_node2-n_0000000000
[junit4] 2> 392366 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:40407/solr/diff456_shard1_replica_n1/ shard1
[junit4] 2> 392467 INFO (zkCallback-3522-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/diff456/state.json] for collection [diff456] has occurred - updating... (live nodes size: [1])
[junit4] 2> 392468 INFO (zkCallback-3522-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/diff456/state.json] for collection [diff456] has occurred - updating... (live nodes size: [1])
[junit4] 2> 392469 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr c:diff456 s:shard1 r:core_node2 x:diff456_shard1_replica_n1 ] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 392471 INFO (qtp1311789955-5505) [n:127.0.0.1:40407_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=testDiff&newCollection=true&name=diff456_shard1_replica_n1&action=CREATE&numShards=1&collection=diff456&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=310
[junit4] 2> 392473 INFO (qtp1311789955-5507) [n:127.0.0.1:40407_solr ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 392571 INFO (zkCallback-3522-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/diff456/state.json] for collection [diff456] has occurred - updating... (live nodes size: [1])
[junit4] 2> 392571 INFO (zkCallback-3522-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/diff456/state.json] for collection [diff456] has occurred - updating... (live nodes size: [1])
[junit4] 2> 392571 INFO (zkCallback-3522-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:
[...truncated too long message...]
closer-3884-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 453046 INFO (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 453149 WARN (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker-SendThread(127.0.0.1:33515)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x100e41c9e4d0001.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x100e41c9e4d0001, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x100e41c9e4d0001, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 453251 WARN (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 21 /solr/configs/._designer_techproducts/managed-schema
[junit4] 2> 19 /solr/configs/._designer_testJson/managed-schema
[junit4] 2> 14 /solr/collections/._designer_testJson/state.json
[junit4] 2> 12 /solr/collections/._designer_testJson/terms/shard1
[junit4] 2> 11 /solr/configs/._designer_testJson
[junit4] 2> 9 /solr/configs/._designer_testDiff/managed-schema
[junit4] 2> 8 /solr/collections/._designer_testDiff/state.json
[junit4] 2> 6 /solr/configs/._designer_testDiff
[junit4] 2> 6 /solr/collections/._designer_testDiff/terms/shard1
[junit4] 2> 5 /solr/configs/._designer_fieldUpdates/managed-schema
[junit4] 2> 4 /solr/configs/._designer_fieldUpdates
[junit4] 2> 4 /solr/collections/test123/state.json
[junit4] 2> 4 /solr/collections/.system/state.json
[junit4] 2> 4 /solr/aliases.json
[junit4] 2> 4 /solr/collections/._designer_fieldUpdates/state.json
[junit4] 2> 4 /solr/collections/test123/terms/shard1
[junit4] 2> 4 /solr/collections/.system/terms/shard1
[junit4] 2> 4 /solr/collections/diff456/state.json
[junit4] 2> 4 /solr/collections/._designer_techproducts/state.json
[junit4] 2> 4 /solr/collections/._designer_testTSV/state.json
[junit4] 2> 4 /solr/collections/._designer_techproducts/terms/shard1
[junit4] 2> 4 /solr/collections/._designer_testTSV/terms/shard1
[junit4] 2> 4 /solr/collections/._designer_films/terms/shard1
[junit4] 2> 4 /solr/collections/._designer_films/state.json
[junit4] 2> 4 /solr/collections/techproducts/state.json
[junit4] 2> 4 /solr/collections/techproducts/terms/shard1
[junit4] 2> 4 /solr/clusterprops.json
[junit4] 2> 3 /solr/configs/._designer_testTSV/managed-schema
[junit4] 2> 3 /solr/configs/._designer_techproducts
[junit4] 2> 3 /solr/configs/._designer_films/managed-schema
[junit4] 2> 3 /solr/collections/._designer_fieldUpdates/terms/shard1
[junit4] 2> 3 /solr/configs/._designer_films
[junit4] 2> 3 /solr/collections/diff456/terms/shard1
[junit4] 2> 2 /solr/configs/techproducts
[junit4] 2> 2 /solr/configs/techproducts/managed-schema
[junit4] 2> 2 /solr/configs/._designer_testTSV
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 30 /solr/collections/._designer_testJson/state.json
[junit4] 2> 25 /solr/configs/._designer_techproducts/managed-schema
[junit4] 2> 18 /solr/collections/._designer_testDiff/state.json
[junit4] 2> 15 /solr/configs/._designer_testJson/managed-schema
[junit4] 2> 12 /solr/collections/._designer_films/state.json
[junit4] 2> 11 /solr/collections/._designer_testTSV/state.json
[junit4] 2> 11 /solr/collections/techproducts/state.json
[junit4] 2> 10 /solr/collections/.system/state.json
[junit4] 2> 9 /solr/collections/._designer_techproducts/state.json
[junit4] 2> 9 /solr/collections/test123/state.json
[junit4] 2> 9 /solr/collections/._designer_fieldUpdates/state.json
[junit4] 2> 9 /solr/collections/diff456/state.json
[junit4] 2> 6 /solr/configs/._designer_fieldUpdates/managed-schema
[junit4] 2> 4 /solr/configs/._designer_testDiff/managed-schema
[junit4] 2> 4 /solr/aliases.json
[junit4] 2> 4 /solr/clusterstate.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 194 /solr/overseer/collection-queue-work
[junit4] 2> 169 /solr/overseer/queue
[junit4] 2> 88 /solr/collections
[junit4] 2> 12 /solr/collections/._designer_testJson/state.json
[junit4] 2> 8 /solr/collections/._designer_testDiff/state.json
[junit4] 2> 5 /solr/collections/.system/state.json
[junit4] 2> 5 /solr/live_nodes
[junit4] 2> 4 /solr/collections/._designer_testTSV/state.json
[junit4] 2> 4 /solr/collections/._designer_techproducts/state.json
[junit4] 2> 4 /solr/collections/test123/state.json
[junit4] 2> 4 /solr/collections/._designer_films/state.json
[junit4] 2> 4 /solr/collections/techproducts/state.json
[junit4] 2> 4 /solr/collections/._designer_fieldUpdates/state.json
[junit4] 2> 4 /solr/collections/diff456/state.json
[junit4] 2>
[junit4] 2> 453266 INFO (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:33515
[junit4] 2> 453266 INFO (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:33515
[junit4] 2> 453266 INFO (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 33515
[junit4] 2> 453266 INFO (SUITE-TestSchemaDesignerAPI-seed#[F7C96A85EDC4EC48]-worker) [ ] o.a.s.SolrTestCaseJ4 ------------------------------------------------------- Done waiting for tracked resources to be released
[junit4] 2> NOTE: test params are: codec=FastDecompressionCompressingStoredFieldsData(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST_DECOMPRESSION, chunkSize=99, maxDocsPerChunk=9, blockShift=10), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST_DECOMPRESSION, chunkSize=99, maxDocsPerChunk=9, blockSize=10)), sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=vi-VN, timezone=US/Central
[junit4] 2> NOTE: Linux 4.15.0-147-generic amd64/Oracle Corporation 1.8.0_291 (64-bit)/cpus=4,threads=1,free=163778176,total=536346624
[junit4] 2> NOTE: All tests run in this JVM: [HdfsCollectionsAPIDistributedZkTest, SimpleCollectionCreateDeleteTest, TestExtendedDismaxParser, CoreAdminHandlerTest, ZkCollectionPropsCachingTest, SuggesterTSTTest, TestIntervalFaceting, TestDocBasedVersionConstraints, TestMinMaxOnMultiValuedField, OverseerSolrResponseTest, ZookeeperStatusHandlerFailureTest, AnalysisAfterCoreReloadTest, TestSchemaSimilarityResource, TolerantUpdateProcessorTest, TestCloudJSONFacetJoinDomain, UtilsToolTest, TestExportTool, ConcurrentCreateCollectionTest, OutputWriterTest, CloneFieldUpdateProcessorFactoryTest, SpellingQueryConverterTest, TestSolrDeletionPolicy1, DistributedQueryComponentCustomSortTest, PreAnalyzedFieldTest, DistributedFacetPivotSmallAdvancedTest, NodeAddedTriggerIntegrationTest, TestLegacyNumericRangeQueryBuilder, ReplaceNodeTest, TestRealTimeGet, TestSQLHandler, DistributedVersionInfoTest, TestMultiWordSynonyms, XsltUpdateRequestHandlerTest, TestDynamicLoadingUrl, RuleEngineTest, TestLegacyFieldCache, TestIndexSearcher, BadIndexSchemaTest, SolrLogAuditLoggerPluginTest, RecoveryZkTest, TestFuzzyAnalyzedSuggestions, MetricsConfigTest, TestPerFieldSimilarity, TestSortableTextField, DocValuesMultiTest, TestExclusionRuleCollectionAccess, SchemaApiFailureTest, ClusterStateMockUtilTest, TestSchemaDesignerAPI]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestSchemaDesignerAPI -Dtests.seed=F7C96A85EDC4EC48 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=vi-VN -Dtests.timezone=US/Central -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J0 | TestSchemaDesignerAPI (suite) <<<
[junit4] > Throwable #1: java.util.concurrent.TimeoutException: Timed out waiting for all collections to be fully removed.
[junit4] > at __randomizedtesting.SeedInfo.seed([F7C96A85EDC4EC48]:0)
[junit4] > at org.apache.solr.cloud.MiniSolrCloudCluster.deleteAllCollections(MiniSolrCloudCluster.java:581)
[junit4] > at org.apache.solr.handler.designer.TestSchemaDesignerAPI.tearDownCluster(TestSchemaDesignerAPI.java:82)
[junit4] > at java.lang.Thread.run(Thread.java:748)Throwable #2: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=5770, name=Thread-686, state=RUNNABLE, group=TGRP-TestSchemaDesignerAPI]
[junit4] > Caused by: java.lang.AssertionError
[junit4] > at __randomizedtesting.SeedInfo.seed([F7C96A85EDC4EC48]:0)
[junit4] > at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1750)
[junit4] > at org.apache.solr.core.SolrCore.lambda$getConfListener$19(SolrCore.java:3147)
[junit4] > at org.apache.solr.cloud.ZkController.lambda$fireEventListeners$15(ZkController.java:2630)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] Completed [159/946 (1!)] on J0 in 70.36s, 6 tests, 2 errors <<< FAILURES!
[...truncated 56856 lines...]
[JENKINS] Lucene » Lucene-Solr-Tests-8.x - Build # 3070 - Still Unstable!
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.x/3070/
1 tests failed.
FAILED: org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest.test
Error Message:
Error from server at http://127.0.0.1:35463/cw_d/collection1: org.apache.solr.client.solrj.SolrServerException: Time allowed to handle this request exceeded:[http://[::1]:8/cw_d, http://[::1]:4/cw_d, http://[::1]:6/cw_d]
Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:35463/cw_d/collection1: org.apache.solr.client.solrj.SolrServerException: Time allowed to handle this request exceeded:[http://[::1]:8/cw_d, http://[::1]:4/cw_d, http://[::1]:6/cw_d]
at __randomizedtesting.SeedInfo.seed([DA710C3845926649:522533E2EB6E0BB1]:0)
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:681)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:266)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:214)
at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1003)
at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1018)
at org.apache.solr.BaseDistributedSearchTestCase.queryServer(BaseDistributedSearchTestCase.java:623)
at org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest.queryAllowPartialResults(DistributedQueryComponentCustomSortTest.java:139)
at org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest.test(DistributedQueryComponentCustomSortTest.java:129)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1084)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1055)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 15625 lines...]
[junit4] Suite: org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest
[junit4] 2> 2064424 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/server/solr/configsets/_default/conf'
[junit4] 2> 2064424 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 2064424 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_DA710C3845926649-001/data-dir-175-001
[junit4] 2> 2064425 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=9 numCloses=9
[junit4] 2> 2064425 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 2064426 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 2064426 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /cw_d/
[junit4] 2> 2064427 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 2064432 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2064446 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.10.0
[junit4] 2> 2064447 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
[junit4] 2> 2064447 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead
[junit4] 2> 2064448 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort
[junit4] 2> 2064448 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 with uniqueid field id
[junit4] 2> 2065296 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.c.CoreContainer Unable to create [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/userfiles]. Features requiring this directory may fail.
[junit4] 2> => java.security.AccessControlException: access denied ("java.io.FilePermission" "/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/userfiles" "write")
[junit4] 2> at java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
[junit4] 2> java.security.AccessControlException: access denied ("java.io.FilePermission" "/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/userfiles" "write")
[junit4] 2> at java.security.AccessControlContext.checkPermission(AccessControlContext.java:472) ~[?:1.8.0_291]
[junit4] 2> at java.security.AccessController.checkPermission(AccessController.java:886) ~[?:1.8.0_291]
[junit4] 2> at java.lang.SecurityManager.checkPermission(SecurityManager.java:549) ~[?:1.8.0_291]
[junit4] 2> at java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_291]
[junit4] 2> at sun.nio.fs.UnixPath.checkWrite(UnixPath.java:801) ~[?:?]
[junit4] 2> at sun.nio.fs.UnixFileSystemProvider.createDirectory(UnixFileSystemProvider.java:376) ~[?:?]
[junit4] 2> at java.nio.file.Files.createDirectory(Files.java:674) ~[?:1.8.0_291]
[junit4] 2> at java.nio.file.Files.createAndCheckIsDirectory(Files.java:781) ~[?:1.8.0_291]
[junit4] 2> at java.nio.file.Files.createDirectories(Files.java:727) ~[?:1.8.0_291]
[junit4] 2> at org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:378) [java/:?]
[junit4] 2> at org.apache.solr.core.CoreContainer.<init>(CoreContainer.java:343) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:183) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:156) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:162) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:812) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:802) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:663) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:652) [java/:?]
[junit4] 2> at org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest.setUpBeforeClass(DistributedQueryComponentCustomSortTest.java:44) [test/:?]
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_291]
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_291]
[junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_291]
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_291]
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:878) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at org.junit.rules.RunRules.evaluate(RunRules.java:20) [junit-4.13.1.jar:4.13.1]
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [java/:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) [java/:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) [java/:?]
[junit4] 2> at org.junit.rules.RunRules.evaluate(RunRules.java:20) [junit-4.13.1.jar:4.13.1]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at java.lang.Thread.run(Thread.java:748) [?:1.8.0_291]
[junit4] 2> 2065297 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.f.DistribPackageStore Unable to create [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/filestore] directory in SOLR_HOME [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr]. Features requiring this directory may fail.
[junit4] 2> => java.security.AccessControlException: access denied ("java.io.FilePermission" "/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/filestore" "write")
[junit4] 2> at java.security.AccessControlContext.checkPermission(AccessControlContext.java:472)
[junit4] 2> java.security.AccessControlException: access denied ("java.io.FilePermission" "/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/filestore" "write")
[junit4] 2> at java.security.AccessControlContext.checkPermission(AccessControlContext.java:472) ~[?:1.8.0_291]
[junit4] 2> at java.security.AccessController.checkPermission(AccessController.java:886) ~[?:1.8.0_291]
[junit4] 2> at java.lang.SecurityManager.checkPermission(SecurityManager.java:549) ~[?:1.8.0_291]
[junit4] 2> at java.lang.SecurityManager.checkWrite(SecurityManager.java:979) ~[?:1.8.0_291]
[junit4] 2> at java.io.File.mkdir(File.java:1348) ~[?:1.8.0_291]
[junit4] 2> at java.io.File.mkdirs(File.java:1380) ~[?:1.8.0_291]
[junit4] 2> at org.apache.solr.filestore.DistribPackageStore.ensurePackageStoreDir(DistribPackageStore.java:561) [java/:?]
[junit4] 2> at org.apache.solr.filestore.DistribPackageStore.<init>(DistribPackageStore.java:81) [java/:?]
[junit4] 2> at org.apache.solr.filestore.PackageStoreAPI.<init>(PackageStoreAPI.java:78) [java/:?]
[junit4] 2> at org.apache.solr.core.CoreContainer.load(CoreContainer.java:679) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:184) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:156) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:162) [java/:?]
[junit4] 2> at org.apache.solr.util.TestHarness.<init>(TestHarness.java:112) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:812) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:802) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:663) [java/:?]
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.initCore(SolrTestCaseJ4.java:652) [java/:?]
[junit4] 2> at org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest.setUpBeforeClass(DistributedQueryComponentCustomSortTest.java:44) [test/:?]
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_291]
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_291]
[junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_291]
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_291]
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:878) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at org.junit.rules.RunRules.evaluate(RunRules.java:20) [junit-4.13.1.jar:4.13.1]
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [java/:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) [java/:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) [java/:?]
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) [java/:?]
[junit4] 2> at org.junit.rules.RunRules.evaluate(RunRules.java:20) [junit-4.13.1.jar:4.13.1]
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) [randomizedtesting-runner-2.7.2.jar:?]
[junit4] 2> at java.lang.Thread.run(Thread.java:748) [?:1.8.0_291]
[junit4] 2> 2065298 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 2065299 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@7b4842cf[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2065299 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@7b4842cf[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2065301 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@5dd83943[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2065301 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@5dd83943[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2065303 WARN (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 2065341 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2135cefe
[junit4] 2> 2065348 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2135cefe
[junit4] 2> 2065348 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2135cefe
[junit4] 2> 2065349 INFO (coreLoadExecutor-17301-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 2147483647 cores with initial capacity of 1024
[junit4] 2> 2065356 INFO (coreLoadExecutor-17301-thread-1) [ x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2065454 INFO (coreLoadExecutor-17301-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.10.0
[junit4] 2> 2065454 WARN (coreLoadExecutor-17301-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
[junit4] 2> 2065454 WARN (coreLoadExecutor-17301-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead
[junit4] 2> 2065456 INFO (coreLoadExecutor-17301-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort
[junit4] 2> 2065456 INFO (coreLoadExecutor-17301-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 with uniqueid field id
[junit4] 2> 2065456 INFO (coreLoadExecutor-17301-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 2065456 INFO (coreLoadExecutor-17301-thread-1) [ x:collection1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2135cefe
[junit4] 2> 2065456 INFO (coreLoadExecutor-17301-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_DA710C3845926649-001/data-dir-175-001/]
[junit4] 2> 2065457 INFO (coreLoadExecutor-17301-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=100.03515625, floorSegmentMB=2.193359375, forceMergeDeletesPctAllowed=15.520023253472614, segmentsPerTier=28.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5332298104730945, deletesPctAllowed=22.43461381644192
[junit4] 2> 2065585 INFO (coreLoadExecutor-17301-thread-1) [ x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 2065585 INFO (coreLoadExecutor-17301-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2065586 INFO (coreLoadExecutor-17301-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2065586 INFO (coreLoadExecutor-17301-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2065586 INFO (coreLoadExecutor-17301-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=19, maxMergeAtOnceExplicit=37, maxMergedSegmentMB=80.1953125, floorSegmentMB=1.974609375, forceMergeDeletesPctAllowed=20.209473705056652, segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4990601971585906, deletesPctAllowed=24.00223926490879
[junit4] 2> 2065587 INFO (coreLoadExecutor-17301-thread-1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 2065604 INFO (coreLoadExecutor-17301-thread-1) [ x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 2065673 INFO (coreLoadExecutor-17301-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 2065673 INFO (coreLoadExecutor-17301-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1709318247487111168
[junit4] 2> 2065675 INFO (searcherExecutor-17303-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 2065675 INFO (searcherExecutor-17303-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 2065675 INFO (searcherExecutor-17303-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 2065675 INFO (searcherExecutor-17303-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 2065675 INFO (searcherExecutor-17303-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 2065675 INFO (searcherExecutor-17303-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 2065675 INFO (searcherExecutor-17303-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 2065676 INFO (searcherExecutor-17303-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 2065676 INFO (searcherExecutor-17303-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 2065677 INFO (searcherExecutor-17303-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2065679 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 2066012 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_DA710C3845926649-001/tempDir-001/control/cores/collection1
[junit4] 2> 2066013 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 2066013 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 2066013 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
[junit4] 2> 2066021 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2066021 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2066021 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2066023 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2f69e118{/cw_d,null,AVAILABLE}
[junit4] 2> 2066023 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1227cfde{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:44005}
[junit4] 2> 2066023 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.s.Server Started @2066053ms
[junit4] 2> 2066023 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema-custom-field.xml, solrconfig=solrconfig.xml, hostContext=/cw_d, hostPort=44005, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_DA710C3845926649-001/tempDir-001/control/cores}
[junit4] 2> 2066023 ERROR (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2066024 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2066024 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.10.0
[junit4] 2> 2066024 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 2066024 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
[junit4] 2> 2066024 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-08-28T06:41:51.544Z
[junit4] 2> 2066024 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_DA710C3845926649-001/tempDir-001/control/solr.xml
[junit4] 2> 2066027 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 2066027 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 2066028 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@2135cefe, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 2067007 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 2067011 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@3b7273e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2067011 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@3b7273e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2067163 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@45865ed1[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2067163 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@45865ed1[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2067165 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 2067200 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4
[junit4] 2> 2067201 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 2067222 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2135cefe
[junit4] 2> 2067242 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2135cefe
[junit4] 2> 2067243 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2135cefe
[junit4] 2> 2067244 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_DA710C3845926649-001/tempDir-001/control/cores
[junit4] 2> 2067244 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 2067327 INFO (coreLoadExecutor-17321-thread-1) [ x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2067370 INFO (coreLoadExecutor-17321-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.10.0
[junit4] 2> 2067370 WARN (coreLoadExecutor-17321-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
[junit4] 2> 2067372 WARN (coreLoadExecutor-17321-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead
[junit4] 2> 2067374 INFO (coreLoadExecutor-17321-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort
[junit4] 2> 2067374 INFO (coreLoadExecutor-17321-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 with uniqueid field id
[junit4] 2> 2067374 INFO (coreLoadExecutor-17321-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 2067374 INFO (coreLoadExecutor-17321-thread-1) [ x:collection1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2135cefe
[junit4] 2> 2067375 INFO (coreLoadExecutor-17321-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_DA710C3845926649-001/tempDir-001/control/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_DA710C3845926649-001/tempDir-001/control/cores/collection1/data/]
[junit4] 2> 2067376 INFO (coreLoadExecutor-17321-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=100.03515625, floorSegmentMB=2.193359375, forceMergeDeletesPctAllowed=15.520023253472614, segmentsPerTier=28.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5332298104730945, deletesPctAllowed=22.43461381644192
[junit4] 2> 2067428 INFO (coreLoadExecutor-17321-thread-1) [ x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 2067428 INFO (coreLoadExecutor-17321-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2067429 INFO (coreLoadExecutor-17321-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2067429 INFO (coreLoadExecutor-17321-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2067430 INFO (coreLoadExecutor-17321-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=19, maxMergeAtOnceExplicit=37, maxMergedSegmentMB=80.1953125, floorSegmentMB=1.974609375, forceMergeDeletesPctAllowed=20.209473705056652, segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4990601971585906, deletesPctAllowed=24.00223926490879
[junit4] 2> 2067431 INFO (coreLoadExecutor-17321-thread-1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 2067506 INFO (coreLoadExecutor-17321-thread-1) [ x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 2067575 INFO (coreLoadExecutor-17321-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 2067576 INFO (coreLoadExecutor-17321-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1709318249482551296
[junit4] 2> 2067578 INFO (searcherExecutor-17323-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 2067578 INFO (searcherExecutor-17323-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 2067578 INFO (searcherExecutor-17323-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 2067578 INFO (searcherExecutor-17323-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 2067579 INFO (searcherExecutor-17323-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 2067579 INFO (searcherExecutor-17323-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 2067579 INFO (searcherExecutor-17323-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 2067579 INFO (searcherExecutor-17323-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 2067579 INFO (searcherExecutor-17323-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 2067581 INFO (searcherExecutor-17323-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2067844 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_DA710C3845926649-001/tempDir-001/shard0/cores/collection1
[junit4] 2> 2067847 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 2067847 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 2067847 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
[junit4] 2> 2067858 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2067859 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2067859 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2067863 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@ce4a486{/cw_d,null,AVAILABLE}
[junit4] 2> 2067864 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@45c072ea{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:35463}
[junit4] 2> 2067864 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.s.Server Started @2067893ms
[junit4] 2> 2067864 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema-custom-field.xml, solrconfig=solrconfig.xml, hostContext=/cw_d, hostPort=35463, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_DA710C3845926649-001/tempDir-001/shard0/cores}
[junit4] 2> 2067864 ERROR (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2067864 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2067864 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.10.0
[junit4] 2> 2067864 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 2067864 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
[junit4] 2> 2067864 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-08-28T06:41:53.384Z
[junit4] 2> 2067864 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_DA710C3845926649-001/tempDir-001/shard0/solr.xml
[junit4] 2> 2067867 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 2067867 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 2067868 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@2135cefe, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 2069594 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 2069594 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@5f1cf88b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2069594 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@5f1cf88b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2069598 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@4caa4d86[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2069598 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@4caa4d86[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2069599 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 2069610 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4
[junit4] 2> 2069610 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 2069630 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2135cefe
[junit4] 2> 2069642 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2135cefe
[junit4] 2> 2069642 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2135cefe
[junit4] 2> 2069644 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_DA710C3845926649-001/tempDir-001/shard0/cores
[junit4] 2> 2069644 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 2069652 INFO (coreLoadExecutor-17340-thread-1) [ x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2069689 INFO (coreLoadExecutor-17340-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.10.0
[junit4] 2> 2069689 WARN (coreLoadExecutor-17340-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
[junit4] 2> 2069690 WARN (coreLoadExecutor-17340-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead
[junit4] 2> 2069691 INFO (coreLoadExecutor-17340-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort
[junit4] 2> 2069692 INFO (coreLoadExecutor-17340-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 with uniqueid field id
[junit4] 2> 2069692 INFO (coreLoadExecutor-17340-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 2069692 INFO (coreLoadExecutor-17340-thread-1) [ x:collection1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2135cefe
[junit4] 2> 2069692 INFO (coreLoadExecutor-17340-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_DA710C3845926649-001/tempDir-001/shard0/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_DA710C3845926649-001/tempDir-001/shard0/cores/collection1/data/]
[junit4] 2> 2069693 INFO (coreLoadExecutor-17340-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=100.03515625, floorSegmentMB=2.193359375, forceMergeDeletesPctAllowed=15.520023253472614, segmentsPerTier=28.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5332298104730945, deletesPctAllowed=22.43461381644192
[junit4] 2> 2069750 INFO (coreLoadExecutor-17340-thread-1) [ x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 2069751 INFO (coreLoadExecutor-17340-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2069751 INFO (coreLoadExecutor-17340-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2069752 INFO (coreLoadExecutor-17340-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2069752 INFO (coreLoadExecutor-17340-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=19, maxMergeAtOnceExplicit=37, maxMergedSegmentMB=80.1953125, floorSegmentMB=1.974609375, forceMergeDeletesPctAllowed=20.209473705056652, segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4990601971585906, deletesPctAllowed=24.00223926490879
[junit4] 2> 2069754 INFO (coreLoadExecutor-17340-thread-1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 2069770 INFO (coreLoadExecutor-17340-thread-1) [ x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 2069838 INFO (coreLoadExecutor-17340-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 2069838 INFO (coreLoadExecutor-17340-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1709318251854430208
[junit4] 2> 2069840 INFO (searcherExecutor-17342-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 2069840 INFO (searcherExecutor-17342-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 2069840 INFO (searcherExecutor-17342-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 2069840 INFO (searcherExecutor-17342-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 2069840 INFO (searcherExecutor-17342-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 2069840 INFO (searcherExecutor-17342-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 2069840 INFO (searcherExecutor-17342-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 2069841 INFO (searcherExecutor-17342-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 2069841 INFO (searcherExecutor-17342-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 2069843 INFO (searcherExecutor-17342-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2069943 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_DA710C3845926649-001/tempDir-001/shard1/cores/collection1
[junit4] 2> 2069947 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 2069947 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 2069947 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
[junit4] 2> 2070007 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2070007 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2070007 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2070015 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4c23dbb1{/cw_d,null,AVAILABLE}
[junit4] 2> 2070015 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@6eb6f6d1{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:45397}
[junit4] 2> 2070015 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.s.Server Started @2070045ms
[junit4] 2> 2070015 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema-custom-field.xml, solrconfig=solrconfig.xml, hostContext=/cw_d, hostPort=45397, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_DA710C3845926649-001/tempDir-001/shard1/cores}
[junit4] 2> 2070015 ERROR (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2070015 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2070015 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.10.0
[junit4] 2> 2070015 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 2070015 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
[junit4] 2> 2070015 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-08-28T06:41:55.535Z
[junit4] 2> 2070015 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_DA710C3845926649-001/tempDir-001/shard1/solr.xml
[junit4] 2> 2070018 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 2070018 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 2070019 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@2135cefe, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 2072759 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 2072760 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@65752b3f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2072760 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@65752b3f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2072779 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@411d6fa1[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2072779 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@411d6fa1[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2072781 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 2072944 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4
[junit4] 2> 2072944 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 2072966 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2135cefe
[junit4] 2> 2072978 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2135cefe
[junit4] 2> 2072978 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2135cefe
[junit4] 2> 2072980 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_DA710C3845926649-001/tempDir-001/shard1/cores
[junit4] 2> 2072980 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 2073020 INFO (coreLoadExecutor-17359-thread-1) [ x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2073038 INFO (coreLoadExecutor-17359-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.10.0
[junit4] 2> 2073039 WARN (coreLoadExecutor-17359-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
[junit4] 2> 2073039 WARN (coreLoadExecutor-17359-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead
[junit4] 2> 2073040 INFO (coreLoadExecutor-17359-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort
[junit4] 2> 2073041 INFO (coreLoadExecutor-17359-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 with uniqueid field id
[junit4] 2> 2073041 INFO (coreLoadExecutor-17359-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 2073041 INFO (coreLoadExecutor-17359-thread-1) [ x:collection1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2135cefe
[junit4] 2> 2073041 INFO (coreLoadExecutor-17359-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_DA710C3845926649-001/tempDir-001/shard1/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_DA710C3845926649-001/tempDir-001/shard1/cores/collection1/data/]
[junit4] 2> 2073042 INFO (coreLoadExecutor-17359-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=100.03515625, floorSegmentMB=2.193359375, forceMergeDeletesPctAllowed=15.520023253472614, segmentsPerTier=28.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5332298104730945, deletesPctAllowed=22.43461381644192
[junit4] 2> 2073094 INFO (coreLoadExecutor-17359-thread-1) [ x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 2073094 INFO (coreLoadExecutor-17359-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2073095 INFO (coreLoadExecutor-17359-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2073095 INFO (coreLoadExecutor-17359-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2073096 INFO (coreLoadExecutor-17359-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=19, maxMergeAtOnceExplicit=37, maxMergedSegmentMB=80.1953125, floorSegmentMB=1.974609375, forceMergeDeletesPctAllowed=20.209473705056652, segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4990601971585906, deletesPctAllowed=24.00223926490879
[junit4] 2> 2073097 INFO (coreLoadExecutor-17359-thread-1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 2073113 INFO (coreLoadExecutor-17359-thread-1) [ x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 2073315 INFO (coreLoadExecutor-17359-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 2073315 INFO (coreLoadExecutor-17359-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1709318255500328960
[junit4] 2> 2073317 INFO (searcherExecutor-17361-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 2073317 INFO (searcherExecutor-17361-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 2073317 INFO (searcherExecutor-17361-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 2073317 INFO (searcherExecutor-17361-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 2073317 INFO (searcherExecutor-17361-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 2073317 INFO (searcherExecutor-17361-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 2073318 INFO (searcherExecutor-17361-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 2073318 INFO (searcherExecutor-17361-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 2073318 INFO (searcherExecutor-17361-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 2073320 INFO (searcherExecutor-17361-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 2073429 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_DA710C3845926649-001/tempDir-001/shard2/cores/collection1
[junit4] 2> 2073431 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 2073431 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 2073431 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
[junit4] 2> 2073432 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2073432 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2073432 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2073432 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@a969bd7{/cw_d,null,AVAILABLE}
[junit4] 2> 2073432 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@6d61b5b2{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:35635}
[junit4] 2> 2073432 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.s.Server Started @2073462ms
[junit4] 2> 2073432 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema-custom-field.xml, solrconfig=solrconfig.xml, hostContext=/cw_d, hostPort=35635, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_DA710C3845926649-001/tempDir-001/shard2/cores}
[junit4] 2> 2073433 ERROR (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2073433 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2073433 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.10.0
[junit4] 2> 2073433 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 2073433 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
[junit4] 2> 2073433 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-08-28T06:41:58.953Z
[junit4] 2> 2073433 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_DA710C3845926649-001/tempDir-001/shard2/solr.xml
[junit4] 2> 2073437 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 2073437 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 2073439 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@2135cefe, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 2075149 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 2075150 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@47f47adc[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2075150 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@47f47adc[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2075153 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@23db6080[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2075153 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@23db6080[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2075155 WARN (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 2075166 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4
[junit4] 2> 2075166 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 2075186 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2135cefe
[junit4] 2> 2075214 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2135cefe
[junit4] 2> 2075215 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2135cefe
[junit4] 2> 2075216 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_DA710C3845926649-001/tempDir-001/shard2/cores
[junit4] 2> 2075216 INFO (TEST-DistributedQueryComponentCustomSortTest.test-seed#[DA710C3845926649]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 2075227 INFO (coreLoadExecutor-17378-thread-1) [ x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2075249 INFO (coreLoadExecutor-17378-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.10.0
[junit4] 2> 2075249 WARN (coreLoadExecutor-17378-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
[junit4] 2> 2075250 WARN (coreLoadExecutor-17378-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead
[junit4] 2> 2075251 INFO (coreLoadExecutor-17378-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test-custom-field-sort
[junit4] 2> 2075252 INFO (coreLoadExecutor-17378-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test-custom-field-sort/1.6 with uniqueid field id
[junit4] 2> 2075252 INFO (coreLoadExecutor-17378-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 2075252 INFO (coreLoadExecutor-17378-thread-1) [ x:collection1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2135cefe
[junit4] 2> 2075252 INFO (coreLoadExecutor-17378-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_DA710C3845926649-001/tempDir-001/shard2/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_DA710C3845926649-001/tempDir-001/shard2/cores/collection1/data/]
[junit4] 2> 2075253 INFO (coreLoadExecutor-17378-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=100.03515625, floorSegmentMB=2.193359375, forceMergeDeletesPctAllowed=15.520023253472614, segmentsPerTier=28.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5332298104730945, deletesPctAllowed=22.43461381644192
[junit4] 2> 2075311 INFO (coreLoadExecutor-17378-thread-1) [ x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 2075311 INFO (coreLoadExecutor-17378-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2075313 INFO (coreLoadExecutor-17378-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2075313 INFO (coreLoadExecutor-17378-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2075313 INFO (coreLoadExecutor-17378-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=19, maxMergeAtOnceExplicit=37, maxMergedSegmentMB=80.1953125, floorSegmentMB=1.974609375, forceMergeDeletesPctAllowed=20.209473705056652, segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4990601971585906, deletesPctAllowed=24.00223926490879
[junit4] 2> 2075315 INFO (coreLoadExecutor-17378-thread-1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 2075329 INFO (coreLoadExecutor-17378-thread-1) [ x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 2075402 INFO (coreLoadExecutor-17378-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 2075402 INFO (coreLoadExecutor-17378-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1709318257688707072
[junit4] 2> 2075405 INFO (searcherExecutor-17380-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 2075406 INFO (searcherExecutor-17380-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: di
[...truncated too long message...]
Time allowed to handle this request exceeded:[http://[::1]:8/cw_d, http://[::1]:4/cw_d, http://[::1]:6/cw_d]
[junit4] > at __randomizedtesting.SeedInfo.seed([DA710C3845926649:522533E2EB6E0BB1]:0)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:681)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:266)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
[junit4] > at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:214)
[junit4] > at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1003)
[junit4] > at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1018)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase.queryServer(BaseDistributedSearchTestCase.java:623)
[junit4] > at org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest.queryAllowPartialResults(DistributedQueryComponentCustomSortTest.java:139)
[junit4] > at org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest.test(DistributedQueryComponentCustomSortTest.java:129)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1084)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1055)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 2075833 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 2075833 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=552339468
[junit4] 2> 2075833 INFO (coreCloseExecutor-17406-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@75f2e1d1
[junit4] 2> 2075833 INFO (coreCloseExecutor-17406-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1 tag=SolrCore@75f2e1d1
[junit4] 2> 2075833 INFO (coreCloseExecutor-17406-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6692b13d: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1/com.codahale.metrics.MetricRegistry@7232eca2
[junit4] 2> 2075838 INFO (coreCloseExecutor-17406-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED (unnecessary).
[junit4] 2> 2075839 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
[junit4] 2> 2075839 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@49b68f6a: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@415a4ff7
[junit4] 2> 2075840 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
[junit4] 2> 2075840 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3c40f81b: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@30c780ae
[junit4] 2> 2075841 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 2075841 INFO (SUITE-DistributedQueryComponentCustomSortTest-seed#[DA710C3845926649]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2dfe84c4: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@1d39da90
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedQueryComponentCustomSortTest_DA710C3845926649-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene87): {_root_=PostingsFormat(name=LuceneVarGapFixedInterval), id=PostingsFormat(name=LuceneVarGapDocFreqInterval), text=Lucene84, asdfasdf_field_should_match_catchall_dynamic_field_adsfasdf=PostingsFormat(name=LuceneVarGapFixedInterval)}, docValues:{payload=DocValuesFormat(name=Direct)}, maxPointsInLeafNode=1380, maxMBSortInHeap=6.510089948547874, sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=en-IN, timezone=Iran
[junit4] 2> NOTE: Linux 4.15.0-147-generic amd64/Oracle Corporation 1.8.0_291 (64-bit)/cpus=4,threads=1,free=64858712,total=525336576
[junit4] 2> NOTE: All tests run in this JVM: [SolrCLIZkUtilsTest, TestTolerantUpdateProcessorCloud, ConcurrentDeleteAndCreateCollectionTest, TestSchemaField, TestSolrCoreProperties, HttpPartitionOnCommitTest, TestDistribIDF, TestDynamicFieldResource, HdfsNNFailoverTest, PackageManagerCLITest, AdminHandlersProxyTest, TransactionLogTest, TestTextField, RequestHandlersTest, FuzzySearchTest, PropertiesRequestHandlerTest, TestReplicationHandlerDiskOverFlow, TestDocTermOrdsUninvertLimit, SplitByPrefixTest, BasicFunctionalityTest, ConnectionReuseTest, TestTestInjection, TestDynamicURP, NodeAddedTriggerTest, DistributedFacetPivotSmallTest, TestSimExecutePlanAction, TestBinaryField, LocalFSCloudIncrementalBackupTest, TestDistributedMap, RulesTest, SQLWithAuthzEnabledTest, BooleanFieldTest, TestSegmentSorting, TestDelegationWithHadoopAuth, CollectionTooManyReplicasTest, DocValuesTest, TestLocalFSCloudBackupRestore, TestCollapseQParserPlugin, RestoreTriggerStateTest, TestRestManager, HdfsAutoAddReplicasIntegrationTest, HealthCheckHandlerTest, DefaultValueUpdateProcessorTest, TestPerFieldSimilarityWithDefaultOverride, URLClassifyProcessorTest, SearchHandlerTest, XMLAtomicUpdateMultivalueTest, TestSQLHandlerNonCloud, CoreAdminOperationTest, TestFoldingMultitermQuery, DistribDocExpirationUpdateProcessorTest, TestRandomRequestDistribution, TestJmxIntegration, TestConfigSetsAPIZkFailure, TestSearchPerf, TestDistributedSearch, TestHdfsBackupRestoreCore, TestLegacyTerms, RootFieldTest, UninvertDocValuesMergePolicyTest, TestInPlaceUpdatesStandalone, TestCrossCoreJoin, TestScoreJoinQPScore, BufferStoreTest, ExplicitHLLTest, LeaderElectionIntegrationTest, LeaderTragicEventTest, AggValueSourceTest, TestReversedWildcardFilterFactory, ZookeeperStatusHandlerTest, ChaosMonkeyNothingIsSafeTest, TestClusterProperties, TestApiFramework, CdcrBidirectionalTest, HdfsBasicDistributedZk2Test, TestNumericTokenStream, CreateRoutedAliasTest, TestStandardQParsers, ZkFailoverTest, ConjunctionSolrSpellCheckerTest, TestFieldTypeResource, BasicAuthStandaloneTest, TestSolr4Spatial, TestStressUserVersions, TestWithCollection, IndexSizeTriggerTest, TestOrdValues, TestHdfsUpdateLog, CoreSorterTest, HdfsDirectoryFactoryTest, ZkStateReaderTest, TestBinaryResponseWriter, TestSolrFieldCacheBean, TestFieldCacheSortRandom, TestLMJelinekMercerSimilarityFactory, TestEmbeddedSolrServerAdminHandler, DirectUpdateHandlerTest, TestCorePropertiesReload, JWTVerificationkeyResolverTest, StatelessScriptUpdateProcessorFactoryTest, MoreLikeThisHandlerTest, TestCloudPseudoReturnFields, TestStressInPlaceUpdates, LukeRequestHandlerTest, ShardRoutingTest, DistributedTermsComponentTest, PhrasesIdentificationComponentTest, HighlighterConfigTest, PeerSyncWithBufferUpdatesTest, SchemaVersionSpecificBehaviorTest, MetricsHistoryWithAuthIntegrationTest, AddSchemaFieldsUpdateProcessorFactoryTest, TestRemoteStreaming, AssignBackwardCompatibilityTest, TestDFISimilarityFactory, AutoAddReplicasPlanActionTest, DisMaxRequestHandlerTest, DistributedIntervalFacetingTest, OutputWriterTest, SampleTest, SolrInfoBeanTest, SolrTestCaseJ4DeleteCoreTest, TestHighlightDedupGrouping, TestRandomFaceting, ChaosMonkeySafeLeaderWithPullReplicasTest, DeleteLastCustomShardedReplicaTest, DeleteNodeTest, DeleteReplicaTest, MissingSegmentRecoveryTest, MultiSolrCloudTestCaseTest, NestedShardedAtomicUpdateTest, OverseerCollectionConfigSetProcessorTest, OverseerRolesTest, PeerSyncReplicationTest, SyncSliceTest, TestPullReplicaErrorHandling, TestUtilizeNode, TlogReplayBufferedWhileIndexingTest, TriLevelCompositeIdRoutingTest, UnloadDistributedZkTest, MetricTriggerIntegrationTest, SearchRateTriggerIntegrationTest, SearchRateTriggerTest, TriggerCooldownIntegrationTest, TestSimNodeAddedTrigger, TestSimScenario, TestSimUtils, TestSnapshotCloudManager, CdcrOpsAndBoundariesTest, CdcrReplicationHandlerTest, CdcrRequestHandlerTest, HdfsBasicDistributedZkTest, HdfsChaosMonkeyNothingIsSafeTest, HdfsRecoverLeaseTest, DirectoryFactoriesTest, DirectoryFactoryTest, PluginInfoTest, QueryResultKeyTest, TestCodecSupport, TestConfLoadPerf, TestConfigSetImmutable, TestDynamicLoading, HdfsBackupRepositoryIntegrationTest, TestConfigReload, TestRestoreCore, TestSnapshotCoreBackup, TestStressIncrementalBackup, AutoscalingHistoryHandlerTest, CoreAdminCreateDiscoverTest, CoreAdminRequestStatusTest, IndexSizeEstimatorTest, TestCoreAdminApis, CloudReplicaSourceTest, CustomHighlightComponentTest, DistributedFacetExistsSmallTest, DistributedQueryComponentCustomSortTest]
[junit4] Completed [689/946 (1!)] on J1 in 11.57s, 1 test, 1 error <<< FAILURES!
[...truncated 55128 lines...]