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/05/17 15:30:24 UTC
[JENKINS] Lucene » Lucene-Solr-NightlyTests-8.x - Build # 272 - Unstable!
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-NightlyTests-8.x/272/
2 tests failed.
FAILED: org.apache.solr.cloud.TestStressLiveNodes.testStress
Error Message:
iter142: [127.0.0.1:41929_solr, thrasher-T141_2-0, thrasher-T141_2-1, thrasher-T141_2-2, thrasher-T141_2-3, thrasher-T141_2-4] expected:<1> but was:<6>
Stack Trace:
java.lang.AssertionError: iter142: [127.0.0.1:41929_solr, thrasher-T141_2-0, thrasher-T141_2-1, thrasher-T141_2-2, thrasher-T141_2-3, thrasher-T141_2-4] expected:<1> but was:<6>
at __randomizedtesting.SeedInfo.seed([93774CE354701F6A:866C3122D787E711]:0)
at org.junit.Assert.fail(Assert.java:89)
at org.junit.Assert.failNotEquals(Assert.java:835)
at org.junit.Assert.assertEquals(Assert.java:647)
at org.apache.solr.cloud.TestStressLiveNodes.testStress(TestStressLiveNodes.java:140)
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 com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED: org.apache.solr.cloud.UnloadDistributedZkTest.test
Error Message:
Captured an uncaught exception in thread: Thread[id=71785, name=testExecutor-21241-thread-7, state=RUNNABLE, group=TGRP-UnloadDistributedZkTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=71785, name=testExecutor-21241-thread-7, state=RUNNABLE, group=TGRP-UnloadDistributedZkTest]
Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:40323/elcjk/hl: ADDREPLICA failed to create replica
at __randomizedtesting.SeedInfo.seed([93774CE354701F6A]: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.SolrRequest.process(SolrRequest.java:231)
at org.apache.solr.cloud.BasicDistributedZkTest.lambda$createCollectionInOneInstance$2(BasicDistributedZkTest.java:760)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:218)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 14972 lines...]
[junit4] Suite: org.apache.solr.cloud.TestStressLiveNodes
[junit4] 2> 2697408 INFO (SUITE-TestStressLiveNodes-seed#[93774CE354701F6A]-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-NightlyTests-8.x/checkout/solr/server/solr/configsets/_default/conf'
[junit4] 2> 2697408 INFO (SUITE-TestStressLiveNodes-seed#[93774CE354701F6A]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.TestStressLiveNodes_93774CE354701F6A-001/data-dir-144-001
[junit4] 2> 2697408 WARN (SUITE-TestStressLiveNodes-seed#[93774CE354701F6A]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=14 numCloses=14
[junit4] 2> 2697408 INFO (SUITE-TestStressLiveNodes-seed#[93774CE354701F6A]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 2697419 INFO (SUITE-TestStressLiveNodes-seed#[93774CE354701F6A]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 2697419 INFO (SUITE-TestStressLiveNodes-seed#[93774CE354701F6A]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 2697419 INFO (SUITE-TestStressLiveNodes-seed#[93774CE354701F6A]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.TestStressLiveNodes_93774CE354701F6A-001/tempDir-001
[junit4] 2> 2697419 INFO (SUITE-TestStressLiveNodes-seed#[93774CE354701F6A]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2697420 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 2697420 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 2697424 WARN (ZkTestServer Run Thread) [ ] o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
[junit4] 2> 2697520 INFO (SUITE-TestStressLiveNodes-seed#[93774CE354701F6A]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port: 39487
[junit4] 2> 2697520 INFO (SUITE-TestStressLiveNodes-seed#[93774CE354701F6A]-worker) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:39487
[junit4] 2> 2697520 INFO (SUITE-TestStressLiveNodes-seed#[93774CE354701F6A]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:39487
[junit4] 2> 2697520 INFO (SUITE-TestStressLiveNodes-seed#[93774CE354701F6A]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 39487
[junit4] 2> 2697541 INFO (SUITE-TestStressLiveNodes-seed#[93774CE354701F6A]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2697640 INFO (zkConnectionManagerCallback-19930-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2697799 INFO (SUITE-TestStressLiveNodes-seed#[93774CE354701F6A]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2697908 INFO (SUITE-TestStressLiveNodes-seed#[93774CE354701F6A]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2697925 INFO (zkConnectionManagerCallback-19932-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2697925 INFO (SUITE-TestStressLiveNodes-seed#[93774CE354701F6A]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2697987 INFO (SUITE-TestStressLiveNodes-seed#[93774CE354701F6A]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2698037 INFO (zkConnectionManagerCallback-19934-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2698037 INFO (SUITE-TestStressLiveNodes-seed#[93774CE354701F6A]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2698212 WARN (SUITE-TestStressLiveNodes-seed#[93774CE354701F6A]-worker-SendThread(127.0.0.1:39487)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10531b1a9d40002.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10531b1a9d40002, 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 0x10531b1a9d40002, 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> 2698347 INFO (jetty-launcher-19935-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 2698347 INFO (jetty-launcher-19935-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 2698348 INFO (jetty-launcher-19935-thread-1) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_281-b09
[junit4] 2> 2698628 INFO (jetty-launcher-19935-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2698628 INFO (jetty-launcher-19935-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2698628 INFO (jetty-launcher-19935-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2698631 INFO (jetty-launcher-19935-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@59cc8084{/solr,null,AVAILABLE}
[junit4] 2> 2698632 INFO (jetty-launcher-19935-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5a09ff3f{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:41929}
[junit4] 2> 2698632 INFO (jetty-launcher-19935-thread-1) [ ] o.e.j.s.Server Started @2698661ms
[junit4] 2> 2698632 INFO (jetty-launcher-19935-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, zkHost=127.0.0.1:39487/solr, hostPort=41929}
[junit4] 2> 2698632 ERROR (jetty-launcher-19935-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2698632 INFO (jetty-launcher-19935-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2698633 INFO (jetty-launcher-19935-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.9.0
[junit4] 2> 2698634 INFO (jetty-launcher-19935-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2698634 INFO (jetty-launcher-19935-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr
[junit4] 2> 2698634 INFO (jetty-launcher-19935-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-05-17T14:39:31.161Z
[junit4] 2> 2698708 INFO (jetty-launcher-19935-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2698730 INFO (zkConnectionManagerCallback-19937-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2698730 INFO (jetty-launcher-19935-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2698741 INFO (jetty-launcher-19935-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2698754 INFO (jetty-launcher-19935-thread-1) [ ] o.a.s.c.SolrXmlConfig Metrics collection is disabled.
[junit4] 2> 2705532 INFO (jetty-launcher-19935-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 2705532 WARN (jetty-launcher-19935-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@67a77c42[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2705532 WARN (jetty-launcher-19935-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@67a77c42[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2705535 WARN (jetty-launcher-19935-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@51c81fc8[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2705535 WARN (jetty-launcher-19935-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@51c81fc8[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2705536 INFO (jetty-launcher-19935-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39487/solr
[junit4] 2> 2705541 INFO (jetty-launcher-19935-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2705544 INFO (zkConnectionManagerCallback-19948-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2705545 INFO (jetty-launcher-19935-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2705548 WARN (jetty-launcher-19935-thread-1-SendThread(127.0.0.1:39487)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10531b1a9d40004.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10531b1a9d40004, 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 0x10531b1a9d40004, 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> 2705651 INFO (jetty-launcher-19935-thread-1) [n:127.0.0.1:41929_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2705656 INFO (zkConnectionManagerCallback-19950-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2705656 INFO (jetty-launcher-19935-thread-1) [n:127.0.0.1:41929_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2706125 WARN (jetty-launcher-19935-thread-1) [n:127.0.0.1:41929_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> 2706141 INFO (jetty-launcher-19935-thread-1) [n:127.0.0.1:41929_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:41929_solr
[junit4] 2> 2706145 INFO (jetty-launcher-19935-thread-1) [n:127.0.0.1:41929_solr ] o.a.s.c.Overseer Overseer (id=73519608049696773-127.0.0.1:41929_solr-n_0000000000) starting
[junit4] 2> 2706176 INFO (OverseerStateUpdate-73519608049696773-127.0.0.1:41929_solr-n_0000000000) [n:127.0.0.1:41929_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:41929_solr
[junit4] 2> 2706179 INFO (jetty-launcher-19935-thread-1) [n:127.0.0.1:41929_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:41929_solr
[junit4] 2> 2706181 INFO (OverseerStateUpdate-73519608049696773-127.0.0.1:41929_solr-n_0000000000) [n:127.0.0.1:41929_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2706183 INFO (jetty-launcher-19935-thread-1) [n:127.0.0.1:41929_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 2706184 WARN (jetty-launcher-19935-thread-1) [n:127.0.0.1:41929_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> 2706210 INFO (jetty-launcher-19935-thread-1) [n:127.0.0.1:41929_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.TestStressLiveNodes_93774CE354701F6A-001/tempDir-001/node1
[junit4] 2> 2706247 INFO (SUITE-TestStressLiveNodes-seed#[93774CE354701F6A]-worker) [ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=1
[junit4] 2> 2706247 INFO (SUITE-TestStressLiveNodes-seed#[93774CE354701F6A]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2706249 INFO (zkConnectionManagerCallback-19965-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2706249 INFO (SUITE-TestStressLiveNodes-seed#[93774CE354701F6A]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2706251 INFO (SUITE-TestStressLiveNodes-seed#[93774CE354701F6A]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2706255 INFO (SUITE-TestStressLiveNodes-seed#[93774CE354701F6A]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:39487/solr ready
[junit4] 2> 2706272 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStress
[junit4] 2> 2706273 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2706275 INFO (zkConnectionManagerCallback-19967-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2706275 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2706277 WARN (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]-SendThread(127.0.0.1:39487)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10531b1a9d40007.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10531b1a9d40007, 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 0x10531b1a9d40007, 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> 2706378 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.TestStressLiveNodes preparing parallel adds to live nodes: iter=0, numThreads=3 numNodesPerThread=1
[junit4] 2> 2706380 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2706381 INFO (zkConnectionManagerCallback-19969-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2706381 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2706382 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2706383 INFO (zkConnectionManagerCallback-19971-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2706383 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2706384 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2706384 INFO (zkConnectionManagerCallback-19973-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2706384 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2706387 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (4)
[junit4] 2> 2706387 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (4)
[junit4] 2> 2706388 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2706389 INFO (zkConnectionManagerCallback-19976-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2706389 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2706491 WARN (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]-SendThread(127.0.0.1:39487)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10531b1a9d40008.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10531b1a9d40008, 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 0x10531b1a9d40008, 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> 2706491 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 2706491 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 2706593 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 2706593 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 2706694 WARN (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]-SendThread(127.0.0.1:39487)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10531b1a9d4000a.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10531b1a9d4000a, 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 0x10531b1a9d4000a, 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> 2706694 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 2706694 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 2706814 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2706815 INFO (zkConnectionManagerCallback-19978-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2706815 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2706917 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.TestStressLiveNodes preparing parallel adds to live nodes: iter=1, numThreads=5 numNodesPerThread=2
[junit4] 2> 2706917 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2706918 INFO (zkConnectionManagerCallback-19980-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2706918 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2706919 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2706920 INFO (zkConnectionManagerCallback-19982-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2706920 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2706921 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2706922 INFO (zkConnectionManagerCallback-19984-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2706922 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2706923 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2706924 INFO (zkConnectionManagerCallback-19986-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2706924 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2706925 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2706925 INFO (zkConnectionManagerCallback-19988-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2706926 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2706929 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (5)
[junit4] 2> 2706929 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (5)
[junit4] 2> 2706929 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (7)
[junit4] 2> 2706930 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (7) -> (11)
[junit4] 2> 2706930 INFO (zkCallback-19949-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (11)
[junit4] 2> 2706931 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2706932 INFO (zkConnectionManagerCallback-19991-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2706932 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2706933 WARN (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]-SendThread(127.0.0.1:39487)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10531b1a9d40012.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10531b1a9d40012, 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 0x10531b1a9d40012, 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> 2707035 WARN (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]-SendThread(127.0.0.1:39487)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10531b1a9d4000d.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10531b1a9d4000d, 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 0x10531b1a9d4000d, 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> 2707035 INFO (zkCallback-19949-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (11) -> (9)
[junit4] 2> 2707035 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (11) -> (9)
[junit4] 2> 2707136 INFO (zkCallback-19949-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (9) -> (7)
[junit4] 2> 2707136 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (9) -> (7)
[junit4] 2> 2707237 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (7) -> (5)
[junit4] 2> 2707237 INFO (zkCallback-19949-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (7) -> (5)
[junit4] 2> 2707338 WARN (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]-SendThread(127.0.0.1:39487)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10531b1a9d40010.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10531b1a9d40010, 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 0x10531b1a9d40010, 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> 2707339 INFO (zkCallback-19949-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (3)
[junit4] 2> 2707339 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (3)
[junit4] 2> 2707440 INFO (zkCallback-19949-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (1)
[junit4] 2> 2707441 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (1)
[junit4] 2> 2707541 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2707542 INFO (zkConnectionManagerCallback-19993-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2707542 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2707643 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.TestStressLiveNodes preparing parallel adds to live nodes: iter=2, numThreads=2 numNodesPerThread=1
[junit4] 2> 2707644 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2707645 INFO (zkConnectionManagerCallback-19995-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2707645 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2707646 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2707647 INFO (zkConnectionManagerCallback-19997-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2707647 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2707650 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3)
[junit4] 2> 2707650 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2707650 INFO (zkCallback-19949-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3)
[junit4] 2> 2707652 INFO (zkConnectionManagerCallback-20000-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2707652 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2707755 WARN (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]-SendThread(127.0.0.1:39487)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10531b1a9d40014.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10531b1a9d40014, 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 0x10531b1a9d40014, 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> 2707756 INFO (zkCallback-19949-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 2707756 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 2707857 WARN (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]-SendThread(127.0.0.1:39487)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10531b1a9d40015.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10531b1a9d40015, 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 0x10531b1a9d40015, 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> 2707857 INFO (zkCallback-19949-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 2707857 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 2707963 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2707967 INFO (zkConnectionManagerCallback-20002-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2707967 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2707978 WARN (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]-SendThread(127.0.0.1:39487)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10531b1a9d40017.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10531b1a9d40017, 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 0x10531b1a9d40017, 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> 2708080 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.TestStressLiveNodes preparing parallel adds to live nodes: iter=3, numThreads=5 numNodesPerThread=2
[junit4] 2> 2708095 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2708107 INFO (zkConnectionManagerCallback-20004-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2708107 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2708116 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2708125 INFO (zkConnectionManagerCallback-20006-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2708125 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2708153 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2708165 INFO (zkConnectionManagerCallback-20008-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2708165 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2708184 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2708184 INFO (zkConnectionManagerCallback-20010-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2708185 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2708186 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2708189 INFO (zkConnectionManagerCallback-20012-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2708189 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2708191 INFO (zkCallback-19949-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2708191 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2708198 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (4)
[junit4] 2> 2708198 INFO (zkCallback-19949-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (4)
[junit4] 2> 2708205 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (8)
[junit4] 2> 2708205 INFO (zkCallback-19949-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (8)
[junit4] 2> 2708208 INFO (zkCallback-19949-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (8) -> (10)
[junit4] 2> 2708208 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (8) -> (10)
[junit4] 2> 2708218 INFO (zkCallback-19949-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (10) -> (11)
[junit4] 2> 2708218 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (10) -> (11)
[junit4] 2> 2708224 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2708254 INFO (zkConnectionManagerCallback-20015-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2708255 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2708379 WARN (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]-SendThread(127.0.0.1:39487)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10531b1a9d40018.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10531b1a9d40018, 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 0x10531b1a9d40018, 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> 2708380 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (11) -> (9)
[junit4] 2> 2708480 INFO (zkCallback-19949-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (11) -> (9)
[junit4] 2> 2708481 WARN (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]-SendThread(127.0.0.1:39487)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10531b1a9d40019.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10531b1a9d40019, 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 0x10531b1a9d40019, 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> 2708482 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (9) -> (7)
[junit4] 2> 2708582 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (9) -> (7)
[junit4] 2> 2708583 WARN (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]-SendThread(127.0.0.1:39487)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10531b1a9d4001a.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10531b1a9d4001a, 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 0x10531b1a9d4001a, 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> 2708685 INFO (zkCallback-19949-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (7) -> (5)
[junit4] 2> 2708685 WARN (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]-SendThread(127.0.0.1:39487)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10531b1a9d4001b.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10531b1a9d4001b, 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 0x10531b1a9d4001b, 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> 2708686 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (7) -> (3)
[junit4] 2> 2708690 INFO (zkCallback-19949-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (3)
[junit4] 2> 2708787 WARN (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]-SendThread(127.0.0.1:39487)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10531b1a9d4001c.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10531b1a9d4001c, 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 0x10531b1a9d4001c, 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> 2708788 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (1)
[junit4] 2> 2708907 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2708907 INFO (zkCallback-19949-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (1)
[junit4] 2> 2708910 INFO (zkConnectionManagerCallback-20017-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2708910 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2709120 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.TestStressLiveNodes preparing parallel adds to live nodes: iter=4, numThreads=3 numNodesPerThread=2
[junit4] 2> 2709128 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2709135 INFO (zkConnectionManagerCallback-20019-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2709135 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2709136 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2709137 INFO (zkConnectionManagerCallback-20021-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2709137 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2709138 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2709139 INFO (zkConnectionManagerCallback-20023-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2709139 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2709140 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3)
[junit4] 2> 2709140 INFO (zkCallback-19949-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3)
[junit4] 2> 2709148 INFO (zkCallback-19949-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (6)
[junit4] 2> 2709148 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (6)
[junit4] 2> 2709160 INFO (zkCallback-19949-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (7)
[junit4] 2> 2709160 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (7)
[junit4] 2> 2709171 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2709174 INFO (zkConnectionManagerCallback-20026-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2709174 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2709192 WARN (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]-SendThread(127.0.0.1:39487)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10531b1a9d40022.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10531b1a9d40022, 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 0x10531b1a9d40022, 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> 2709294 WARN (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]-SendThread(127.0.0.1:39487)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10531b1a9d4001f.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10531b1a9d4001f, 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 0x10531b1a9d4001f, 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> 2709295 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (7) -> (5)
[junit4] 2> 2709534 WARN (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]-SendThread(127.0.0.1:39487)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10531b1a9d40020.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10531b1a9d40020, 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 0x10531b1a9d40020, 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> 2709535 INFO (zkCallback-19949-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (7) -> (5)
[junit4] 2> 2709636 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (3)
[junit4] 2> 2709636 INFO (zkCallback-19949-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (3)
[junit4] 2> 2709637 WARN (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]-SendThread(127.0.0.1:39487)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10531b1a9d40021.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10531b1a9d40021, 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 0x10531b1a9d40021, 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> 2709639 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (1)
[junit4] 2> 2709739 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (1)
[junit4] 2> 2709743 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2709743 INFO (zkConnectionManagerCallback-20028-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2709743 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2709857 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.TestStressLiveNodes preparing parallel adds to live nodes: iter=5, numThreads=5 numNodesPerThread=1
[junit4] 2> 2709862 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2709862 INFO (zkConnectionManagerCallback-20030-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2709862 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2709876 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2709876 INFO (zkConnectionManagerCallback-20032-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2709876 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2709886 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2710098 INFO (zkConnectionManagerCallback-20034-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2710098 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2710099 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2710117 INFO (zkConnectionManagerCallback-20036-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2710117 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2710119 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2710168 INFO (zkConnectionManagerCallback-20038-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2710168 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2710187 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2710187 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2710226 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (5)
[junit4] 2> 2710226 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (4)
[junit4] 2> 2710228 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 2710229 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (6)
[junit4] 2> 2710244 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2710255 INFO (zkConnectionManagerCallback-20041-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2710255 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2710267 WARN (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]-SendThread(127.0.0.1:39487)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10531b1a9d40029.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10531b1a9d40029, 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 0x10531b1a9d40029, 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> 2710514 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 2710514 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (5)
[junit4] 2> 2710614 WARN (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]-SendThread(127.0.0.1:39487)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10531b1a9d40025.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10531b1a9d40025, 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 0x10531b1a9d40025, 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> 2710615 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 2710615 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 2710981 WARN (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]-SendThread(127.0.0.1:39487)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10531b1a9d40026.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10531b1a9d40026, 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 0x10531b1a9d40026, 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> 2710982 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 2710983 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 2711083 WARN (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]-SendThread(127.0.0.1:39487)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10531b1a9d40027.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10531b1a9d40027, 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 0x10531b1a9d40027, 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> 2711084 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 2711084 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 2711185 WARN (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]-SendThread(127.0.0.1:39487)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10531b1a9d40028.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10531b1a9d40028, 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 0x10531b1a9d40028, 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> 2711186 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 2711186 INFO (zkCallback-19949-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 2711314 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2711321 INFO (zkConnectionManagerCallback-20043-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2711321 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2711592 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.TestStressLiveNodes preparing parallel adds to live nodes: iter=6, numThreads=4 numNodesPerThread=5
[junit4] 2> 2711642 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2711643 INFO (zkConnectionManagerCallback-20045-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2711643 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2711644 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2711649 INFO (zkConnectionManagerCallback-20047-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2711649 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2711650 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2711657 INFO (zkConnectionManagerCallback-20049-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2711657 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2711660 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2711661 INFO (zkConnectionManagerCallback-20051-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2711661 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2711675 INFO (zkCallback-19949-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2711676 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2711687 INFO (zkCallback-19949-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2711687 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2711696 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (5)
[junit4] 2> 2711696 INFO (zkCallback-19949-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (5)
[junit4] 2> 2711708 INFO (zkCallback-19949-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (7)
[junit4] 2> 2711708 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (7)
[junit4] 2> 2711718 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (7) -> (9)
[junit4] 2> 2711718 INFO (zkCallback-19949-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (7) -> (9)
[junit4] 2> 2711726 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (9) -> (10)
[junit4] 2> 2711726 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (9) -> (10)
[junit4] 2> 2711728 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (10) -> (11)
[junit4] 2> 2711728 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (10) -> (11)
[junit4] 2> 2711733 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (11) -> (13)
[junit4] 2> 2711733 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (11) -> (13)
[junit4] 2> 2711742 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (13) -> (14)
[junit4] 2> 2711743 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (13) -> (14)
[junit4] 2> 2711748 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (14) -> (15)
[junit4] 2> 2711751 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (14) -> (15)
[junit4] 2> 2711759 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (15) -> (16)
[junit4] 2> 2711759 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (15) -> (16)
[junit4] 2> 2711761 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (16) -> (17)
[junit4] 2> 2711761 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (16) -> (17)
[junit4] 2> 2711767 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (17) -> (18)
[junit4] 2> 2711767 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (17) -> (18)
[junit4] 2> 2711770 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (18) -> (19)
[junit4] 2> 2711771 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (18) -> (19)
[junit4] 2> 2711778 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (19) -> (20)
[junit4] 2> 2711779 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (19) -> (20)
[junit4] 2> 2711791 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (20) -> (21)
[junit4] 2> 2711791 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (20) -> (21)
[junit4] 2> 2711864 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2711895 INFO (zkConnectionManagerCallback-20054-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2711895 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2712212 WARN (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]-SendThread(127.0.0.1:39487)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10531b1a9d4002b.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10531b1a9d4002b, 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 0x10531b1a9d4002b, 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> 2712213 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (21) -> (16)
[junit4] 2> 2712213 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (21) -> (16)
[junit4] 2> 2712315 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (16) -> (11)
[junit4] 2> 2712316 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (16) -> (11)
[junit4] 2> 2712416 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (11) -> (6)
[junit4] 2> 2712416 WARN (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]-SendThread(127.0.0.1:39487)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10531b1a9d4002d.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10531b1a9d4002d, 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 0x10531b1a9d4002d, 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> 2712417 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (11) -> (6)
[junit4] 2> 2712701 WARN (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]-SendThread(127.0.0.1:39487)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10531b1a9d4002e.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10531b1a9d4002e, 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 0x10531b1a9d4002e, 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> 2712701 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (1)
[junit4] 2> 2712703 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (6) -> (1)
[junit4] 2> 2712818 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2712838 INFO (zkConnectionManagerCallback-20056-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2712843 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2713099 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.TestStressLiveNodes preparing parallel adds to live nodes: iter=7, numThreads=4 numNodesPerThread=5
[junit4] 2> 2713100 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2713101 INFO (zkConnectionManagerCallback-20058-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2713101 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2713129 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2713136 INFO (zkConnectionManagerCallback-20060-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2713136 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2713142 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2713149 INFO (zkConnectionManagerCallback-20062-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2713149 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2713167 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2713223 INFO (zkConnectionManagerCallback-20064-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2713223 INFO (TEST-TestStressLiveNodes.testStress-seed#[93774CE354701F6A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2713230 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (4)
[junit4] 2> 2713232 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (4)
[junit4] 2> 2713236 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2713236 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2713240 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (7)
[junit4] 2> 2713241 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (7)
[junit4] 2> 2713247 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (7) -> (9)
[junit4] 2> 2713247 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (7) -> (9)
[junit4] 2> 2713248 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (9) -> (10)
[junit4] 2> 2713249 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (9) -> (10)
[junit4] 2> 2713253 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (10) -> (13)
[junit4] 2> 2713254 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (10) -> (13)
[junit4] 2> 2713263 INFO (zkCallback-19964-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (13) -> (14)
[junit4] 2> 2713263 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (13) -> (14)
[junit4] 2> 2713264 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (14) -> (17)
[junit4] 2> 2713265 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (14) -> (17)
[junit4] 2> 2713276 INFO (zkCallback-19964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (17) -> (18)
[junit4] 2> 2713276 INFO (zkCallback-19949-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (17) -> (18)
[junit4] 2> 2713285
[...truncated too long message...]
tion/state.json
[junit4] 2> 8 /solr/clusterprops.json
[junit4] 2> 8 /solr/clusterstate.json
[junit4] 2> 3 /solr/collections/multiunload/leader_elect/shard1/election/73519614521769996-core_node11-n_0000000005
[junit4] 2> 3 /solr/collections/multiunload/leader_elect/shard2/election/73519614521769996-core_node9-n_0000000004
[junit4] 2> 2 /solr/collections/multiunload/leader_elect/shard1/election/73519614521769996-core_node1-n_0000000000
[junit4] 2> 2 /solr/collections/multiunload/leader_elect/shard1/election/73519614521769996-core_node7-n_0000000003
[junit4] 2> 2 /solr/collections/multiunload/leader_elect/shard1/election/73519614521769996-core_node6-n_0000000002
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 185 /solr/overseer/queue
[junit4] 2> 73 /solr/overseer/collection-queue-work
[junit4] 2> 33 /solr/live_nodes
[junit4] 2> 28 /solr/collections
[junit4] 2> 26 /solr/collections/unloadcollection/state.json
[junit4] 2> 17 /solr/collections/collection1/state.json
[junit4] 2> 5 /solr/collections/multiunload/state.json
[junit4] 2> 5 /solr/collections/test_unload_shard_and_collection/state.json
[junit4] 2> 4 /solr/collections/control_collection/state.json
[junit4] 2>
[junit4] 2> 2874134 INFO (TEST-UnloadDistributedZkTest.test-seed#[93774CE354701F6A]) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:46837
[junit4] 2> 2874134 INFO (TEST-UnloadDistributedZkTest.test-seed#[93774CE354701F6A]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:46837
[junit4] 2> 2874134 INFO (TEST-UnloadDistributedZkTest.test-seed#[93774CE354701F6A]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 46837
[junit4] 2> NOTE: download the large Jenkins line-docs file by running 'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=UnloadDistributedZkTest -Dtests.method=test -Dtests.seed=93774CE354701F6A -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/test-data/enwiki.random.lines.txt -Dtests.locale=en-IE -Dtests.timezone=America/Kentucky/Louisville -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 78.0s J1 | UnloadDistributedZkTest.test <<<
[junit4] > Throwable #1: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=71785, name=testExecutor-21241-thread-7, state=RUNNABLE, group=TGRP-UnloadDistributedZkTest]
[junit4] > Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:40323/elcjk/hl: ADDREPLICA failed to create replica
[junit4] > at __randomizedtesting.SeedInfo.seed([93774CE354701F6A]: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.SolrRequest.process(SolrRequest.java:231)
[junit4] > at org.apache.solr.cloud.BasicDistributedZkTest.lambda$createCollectionInOneInstance$2(BasicDistributedZkTest.java:760)
[junit4] > at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:218)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] > at java.lang.Thread.run(Thread.java:748)Throwable #2: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=71788, name=testExecutor-21241-thread-10, state=RUNNABLE, group=TGRP-UnloadDistributedZkTest]
[junit4] > Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:40323/elcjk/hl: ADDREPLICA failed to create replica
[junit4] > at __randomizedtesting.SeedInfo.seed([93774CE354701F6A]: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.SolrRequest.process(SolrRequest.java:231)
[junit4] > at org.apache.solr.cloud.BasicDistributedZkTest.lambda$createCollectionInOneInstance$2(BasicDistributedZkTest.java:760)
[junit4] > at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:218)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 2874137 INFO (SUITE-UnloadDistributedZkTest-seed#[93774CE354701F6A]-worker) [ ] o.a.s.SolrTestCaseJ4 ------------------------------------------------------- Done waiting for tracked resources to be released
[junit4] 2> May 17, 2021 2:42:26 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene87), sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=en-IE, timezone=America/Kentucky/Louisville
[junit4] 2> NOTE: Linux 5.4.0-45-generic amd64/Oracle Corporation 1.8.0_281 (64-bit)/cpus=4,threads=1,free=201597392,total=522715136
[junit4] 2> NOTE: All tests run in this JVM: [CloudMLTQParserTest, XmlUpdateRequestHandlerTest, AutoScalingHandlerTest, HighlighterWithoutStoredIdTest, HttpTriggerListenerTest, PeerSyncWithBufferUpdatesTest, TestTestInjection, SolrRequestParserTest, ZkStateWriterTest, MetricTriggerIntegrationTest, FastVectorHighlighterTest, TestManagedStopFilterFactory, JWTIssuerConfigTest, TestFiltering, DocumentAnalysisRequestHandlerTest, SolrRrdBackendFactoryTest, ExplicitHLLTest, TestConfig, NodeLostTriggerIntegrationTest, TestHdfsUpdateLog, TestReloadDeadlock, TestSolrIndexConfig, SolrMetricReporterTest, TestSimComputePlanAction, DirectoryFactoriesTest, PingRequestHandlerTest, TestZkChroot, HdfsThreadLeakTest, RoutingToNodesWithPropertiesTest, PackageManagerCLITest, Tagger2Test, TestDefaultStatsCache, MetricsHandlerTest, InfoHandlerTest, TestManagedResourceStorage, CollectionsAPISolrJTest, CollectionsAPIAsyncDistributedZkTest, DistributedMLTComponentTest, TestCrossCoreJoin, HttpSolrCallGetCoreTest, TestConfigsApi, DefaultValueUpdateProcessorTest, DistribDocExpirationUpdateProcessorTest, TestManagedSchema, TestHashPartitioner, TestLMDirichletSimilarityFactory, TestJoin, RankQueryTest, BackupIdTest, ConnectionReuseTest, SolrCLIZkUtilsTest, IndexSchemaRuntimeFieldTest, StressHdfsTest, SolrLogAuditLoggerPluginTest, TestPerFieldSimilarity, TestJsonRangeFacets, CdcrVersionReplicationTest, IndexBasedSpellCheckerTest, PluginInfoTest, DateMathParserTest, TestFastOutputStream, TestSubQueryTransformer, ClassificationUpdateProcessorFactoryTest, TestFuzzyAnalyzedSuggestions, TestSimpleTextCodec, TestPayloadScoreQParserPlugin, BasicAuthOnSingleNodeTest, DocValuesMultiTest, TestWriterPerf, TestCollectionAPI, InfixSuggestersTest, SmileWriterTest, CdcrBootstrapTest, TestReversedWildcardFilterFactory, LeaderTragicEventTest, LeaderElectionIntegrationTest, TestNamedUpdateProcessors, XMLAtomicUpdateMultivalueTest, DeleteReplicaTest, ZkNodePropsTest, TestAnalyzedSuggestions, URLClassifyProcessorTest, AddBlockUpdateTest, CursorMarkTest, TestEmbeddedSolrServerAdminHandler, SpellingQueryConverterTest, TestExtendedDismaxParser, TestDocTermOrds, CoreAdminCreateDiscoverTest, ShardRoutingTest, ChaosMonkeyNothingIsSafeTest, CustomCollectionTest, TestSort, TestMiniSolrCloudClusterSSL, TestCaffeineCache, TestSnapshotCoreBackup, TestSimUtils, TestReqParamsAPI, HttpPartitionOnCommitTest, NestedAtomicUpdateTest, ReindexCollectionTest, TestExportWriter, TestImplicitCoreProperties, ResourceLoaderTest, SchemaApiFailureTest, TestIntervalFaceting, SynonymTokenizerTest, TestComponentsName, TestInPlaceUpdatesStandalone, ReplicationFactorTest, CoreMergeIndexesAdminHandlerTest, TestSolrCloudWithKerberosAlt, TestTolerantUpdateProcessorRandomCloud, TestNumericRangeQuery64, ResponseBuilderTest, TestTermsQParserPlugin, TestQuerySenderListener, HttpPartitionWithTlogReplicasTest, MetricsHistoryWithAuthIntegrationTest, MigrateRouteKeyTest, MoveReplicaHDFSTest, MoveReplicaTest, MultiSolrCloudTestCaseTest, NestedShardedAtomicUpdateTest, OverriddenZkACLAndCredentialsProvidersTest, OverseerSolrResponseTest, OverseerSolrResponseUnsafeSerializationTest, PeerSyncReplicationTest, SplitShardTest, SyncSliceTest, TestCloudDeleteByQuery, TestCloudInspectUtil, TestCloudPhrasesIdentificationComponent, TestCloudPivotFacet, TestCloudPseudoReturnFields, TestCloudRecovery2, TestClusterProperties, TestConfigSetsAPIShareSchema, TestOnReconnectListenerSupport, TestRandomRequestDistribution, TestRequestForwarding, TestSSLRandomization, TestSegmentSorting, TestSolrCloudWithSecureImpersonation, TestStressCloudBlindAtomicUpdates, TriLevelCompositeIdRoutingTest, UnloadDistributedZkTest]
[junit4] Completed [568/938 (2!)] on J1 in 79.04s, 1 test, 1 error <<< FAILURES!
[...truncated 52127 lines...]
[JENKINS] Lucene » Lucene-Solr-NightlyTests-8.x - Build # 273 - Still Unstable!
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-NightlyTests-8.x/273/
1 tests failed.
FAILED: org.apache.solr.handler.component.TestDistributedStatsComponentCardinality.test
Error Message:
Captured an uncaught exception in thread: Thread[id=211234, name=Thread-164431, state=RUNNABLE, group=TGRP-TestDistributedStatsComponentCardinality]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=211234, name=Thread-164431, state=RUNNABLE, group=TGRP-TestDistributedStatsComponentCardinality]
at __randomizedtesting.SeedInfo.seed([C34B1B8865B43E92:4B1F2452CB48536A]:0)
Caused by: junit.framework.AssertionFailedError: .responseHeader.status:200!=0
at __randomizedtesting.SeedInfo.seed([C34B1B8865B43E92]:0)
at junit.framework.Assert.fail(Assert.java:57)
at org.apache.solr.BaseDistributedSearchTestCase.compareSolrResponses(BaseDistributedSearchTestCase.java:1006)
at org.apache.solr.BaseDistributedSearchTestCase.compareResponses(BaseDistributedSearchTestCase.java:1033)
at org.apache.solr.BaseDistributedSearchTestCase$5.run(BaseDistributedSearchTestCase.java:694)
Build Log:
[...truncated 15277 lines...]
[junit4] Suite: org.apache.solr.handler.component.TestDistributedStatsComponentCardinality
[junit4] 2> 3788785 INFO (SUITE-TestDistributedStatsComponentCardinality-seed#[C34B1B8865B43E92]-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-NightlyTests-8.x/checkout/solr/server/solr/configsets/_default/conf'
[junit4] 2> 3788785 INFO (SUITE-TestDistributedStatsComponentCardinality-seed#[C34B1B8865B43E92]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/data-dir-268-001
[junit4] 2> 3788785 WARN (SUITE-TestDistributedStatsComponentCardinality-seed#[C34B1B8865B43E92]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=18 numCloses=18
[junit4] 2> 3788785 INFO (SUITE-TestDistributedStatsComponentCardinality-seed#[C34B1B8865B43E92]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 3788787 INFO (SUITE-TestDistributedStatsComponentCardinality-seed#[C34B1B8865B43E92]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-9062)
[junit4] 2> 3788787 INFO (SUITE-TestDistributedStatsComponentCardinality-seed#[C34B1B8865B43E92]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 3788787 INFO (SUITE-TestDistributedStatsComponentCardinality-seed#[C34B1B8865B43E92]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 2> 3788894 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/control/cores/collection1
[junit4] 2> 3788894 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 3788894 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 3788895 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_281-b09
[junit4] 2> 3788895 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 3788895 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 3788895 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 3788895 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@48d7fb42{/,null,AVAILABLE}
[junit4] 2> 3788896 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@7e031546{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:34537}
[junit4] 2> 3788896 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.Server Started @3788928ms
[junit4] 2> 3788896 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=34537, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/control/cores}
[junit4] 2> 3788896 ERROR (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 3788896 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 3788896 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.9.0
[junit4] 2> 3788896 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 3788896 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr
[junit4] 2> 3788896 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-05-18T14:32:40.438Z
[junit4] 2> 3788896 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/control/solr.xml
[junit4] 2> 3788899 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 3788899 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 3788900 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@970ace, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 3789707 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 3789708 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@2748edc6[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3789708 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@2748edc6[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3789710 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@555ce86e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3789710 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@555ce86e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3789712 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] 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> 3789722 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 3789722 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 3789740 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@970ace
[junit4] 2> 3789748 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@970ace
[junit4] 2> 3789748 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@970ace
[junit4] 2> 3789749 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/control/cores
[junit4] 2> 3789749 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 3789757 INFO (coreLoadExecutor-33111-thread-1) [ x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 3789776 INFO (coreLoadExecutor-33111-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
[junit4] 2> 3789776 WARN (coreLoadExecutor-33111-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
[junit4] 2> 3789776 WARN (coreLoadExecutor-33111-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> 3789779 INFO (coreLoadExecutor-33111-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 3789787 INFO (coreLoadExecutor-33111-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 3789794 INFO (coreLoadExecutor-33111-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 3789794 INFO (coreLoadExecutor-33111-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@970ace
[junit4] 2> 3789794 INFO (coreLoadExecutor-33111-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/control/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/control/cores/collection1/data/]
[junit4] 2> 3789795 INFO (coreLoadExecutor-33111-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=39, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=0.390625, floorSegmentMB=0.7001953125, forceMergeDeletesPctAllowed=5.636554578242614, segmentsPerTier=30.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6756015100032812, deletesPctAllowed=33.36388246444841
[junit4] 2> 3789847 INFO (coreLoadExecutor-33111-thread-1) [ x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 3789847 INFO (coreLoadExecutor-33111-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 3789860 INFO (coreLoadExecutor-33111-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 3789860 INFO (coreLoadExecutor-33111-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 3789860 INFO (coreLoadExecutor-33111-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=33, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=44.52734375, floorSegmentMB=2.130859375, forceMergeDeletesPctAllowed=29.957515355984143, segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0, deletesPctAllowed=45.3085316640974
[junit4] 2> 3789861 INFO (coreLoadExecutor-33111-thread-1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 3789877 INFO (coreLoadExecutor-33111-thread-1) [ x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 3789935 INFO (coreLoadExecutor-33111-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 3789935 INFO (coreLoadExecutor-33111-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1700106979484106752
[junit4] 2> 3789936 INFO (searcherExecutor-33113-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 3789936 INFO (searcherExecutor-33113-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 3789936 INFO (searcherExecutor-33113-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 3789936 INFO (searcherExecutor-33113-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 3789937 INFO (searcherExecutor-33113-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 3789937 INFO (searcherExecutor-33113-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 3789937 INFO (searcherExecutor-33113-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 3789937 INFO (searcherExecutor-33113-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 3789937 INFO (searcherExecutor-33113-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 3789938 INFO (searcherExecutor-33113-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 3790039 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard0/cores/collection1
[junit4] 2> 3790039 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 3790039 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 3790039 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_281-b09
[junit4] 2> 3790040 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 3790040 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 3790040 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 3790040 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@27cbf6bb{/,null,AVAILABLE}
[junit4] 2> 3790040 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@d365ca{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:35491}
[junit4] 2> 3790040 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.Server Started @3790072ms
[junit4] 2> 3790040 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=35491, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard0/cores}
[junit4] 2> 3790041 ERROR (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 3790041 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 3790041 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.9.0
[junit4] 2> 3790041 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 3790041 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr
[junit4] 2> 3790041 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-05-18T14:32:41.583Z
[junit4] 2> 3790041 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard0/solr.xml
[junit4] 2> 3790043 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 3790043 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 3790045 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@970ace, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 3790757 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 3790758 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@450a63f0[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3790758 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@450a63f0[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3790761 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@29f90e2f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3790761 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@29f90e2f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3790762 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] 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> 3790779 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 3790779 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 3790799 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@970ace
[junit4] 2> 3790811 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@970ace
[junit4] 2> 3790811 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@970ace
[junit4] 2> 3790813 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard0/cores
[junit4] 2> 3790813 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 3790822 INFO (coreLoadExecutor-33130-thread-1) [ x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 3790845 INFO (coreLoadExecutor-33130-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
[junit4] 2> 3790845 WARN (coreLoadExecutor-33130-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
[junit4] 2> 3790845 WARN (coreLoadExecutor-33130-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> 3790848 INFO (coreLoadExecutor-33130-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 3790856 INFO (coreLoadExecutor-33130-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 3790863 INFO (coreLoadExecutor-33130-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 3790864 INFO (coreLoadExecutor-33130-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@970ace
[junit4] 2> 3790864 INFO (coreLoadExecutor-33130-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard0/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard0/cores/collection1/data/]
[junit4] 2> 3790865 INFO (coreLoadExecutor-33130-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=39, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=0.390625, floorSegmentMB=0.7001953125, forceMergeDeletesPctAllowed=5.636554578242614, segmentsPerTier=30.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6756015100032812, deletesPctAllowed=33.36388246444841
[junit4] 2> 3790922 INFO (coreLoadExecutor-33130-thread-1) [ x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 3790922 INFO (coreLoadExecutor-33130-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 3790934 INFO (coreLoadExecutor-33130-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 3790934 INFO (coreLoadExecutor-33130-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 3790934 INFO (coreLoadExecutor-33130-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=33, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=44.52734375, floorSegmentMB=2.130859375, forceMergeDeletesPctAllowed=29.957515355984143, segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0, deletesPctAllowed=45.3085316640974
[junit4] 2> 3790935 INFO (coreLoadExecutor-33130-thread-1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 3790949 INFO (coreLoadExecutor-33130-thread-1) [ x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 3791010 INFO (coreLoadExecutor-33130-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 3791010 INFO (coreLoadExecutor-33130-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1700106980611325952
[junit4] 2> 3791011 INFO (searcherExecutor-33132-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 3791011 INFO (searcherExecutor-33132-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 3791011 INFO (searcherExecutor-33132-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 3791011 INFO (searcherExecutor-33132-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 3791011 INFO (searcherExecutor-33132-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 3791012 INFO (searcherExecutor-33132-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 3791012 INFO (searcherExecutor-33132-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 3791012 INFO (searcherExecutor-33132-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 3791012 INFO (searcherExecutor-33132-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 3791014 INFO (searcherExecutor-33132-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 3791122 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard1/cores/collection1
[junit4] 2> 3791123 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 3791123 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 3791123 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_281-b09
[junit4] 2> 3791126 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 3791126 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 3791126 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 3791126 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3d0a2d0f{/,null,AVAILABLE}
[junit4] 2> 3791126 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@14fd900b{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42707}
[junit4] 2> 3791126 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.Server Started @3791158ms
[junit4] 2> 3791126 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=42707, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard1/cores}
[junit4] 2> 3791126 ERROR (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 3791126 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 3791126 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.9.0
[junit4] 2> 3791126 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 3791126 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr
[junit4] 2> 3791126 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-05-18T14:32:42.668Z
[junit4] 2> 3791127 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard1/solr.xml
[junit4] 2> 3791129 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 3791129 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 3791131 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@970ace, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 3791655 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 3791656 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@72ed24f5[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3791656 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@72ed24f5[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3791659 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@57ebab6d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3791659 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@57ebab6d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3791660 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] 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> 3791671 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 3791671 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 3791693 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@970ace
[junit4] 2> 3791705 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@970ace
[junit4] 2> 3791705 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@970ace
[junit4] 2> 3791706 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard1/cores
[junit4] 2> 3791706 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 3791715 INFO (coreLoadExecutor-33149-thread-1) [ x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 3791734 INFO (coreLoadExecutor-33149-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
[junit4] 2> 3791734 WARN (coreLoadExecutor-33149-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
[junit4] 2> 3791734 WARN (coreLoadExecutor-33149-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> 3791737 INFO (coreLoadExecutor-33149-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 3791744 INFO (coreLoadExecutor-33149-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 3791751 INFO (coreLoadExecutor-33149-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 3791751 INFO (coreLoadExecutor-33149-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@970ace
[junit4] 2> 3791752 INFO (coreLoadExecutor-33149-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard1/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard1/cores/collection1/data/]
[junit4] 2> 3791753 INFO (coreLoadExecutor-33149-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=39, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=0.390625, floorSegmentMB=0.7001953125, forceMergeDeletesPctAllowed=5.636554578242614, segmentsPerTier=30.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6756015100032812, deletesPctAllowed=33.36388246444841
[junit4] 2> 3791823 INFO (coreLoadExecutor-33149-thread-1) [ x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 3791823 INFO (coreLoadExecutor-33149-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 3791824 INFO (coreLoadExecutor-33149-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 3791824 INFO (coreLoadExecutor-33149-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 3791826 INFO (coreLoadExecutor-33149-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=33, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=44.52734375, floorSegmentMB=2.130859375, forceMergeDeletesPctAllowed=29.957515355984143, segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0, deletesPctAllowed=45.3085316640974
[junit4] 2> 3791827 INFO (coreLoadExecutor-33149-thread-1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 3791842 INFO (coreLoadExecutor-33149-thread-1) [ x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 3791906 INFO (coreLoadExecutor-33149-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 3791906 INFO (coreLoadExecutor-33149-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1700106981550850048
[junit4] 2> 3791908 INFO (searcherExecutor-33151-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 3791908 INFO (searcherExecutor-33151-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 3791908 INFO (searcherExecutor-33151-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 3791908 INFO (searcherExecutor-33151-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 3791908 INFO (searcherExecutor-33151-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 3791908 INFO (searcherExecutor-33151-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 3791908 INFO (searcherExecutor-33151-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 3791909 INFO (searcherExecutor-33151-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 3791909 INFO (searcherExecutor-33151-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 3791911 INFO (searcherExecutor-33151-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 3792012 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard2/cores/collection1
[junit4] 2> 3792013 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 3792013 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 3792013 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_281-b09
[junit4] 2> 3792014 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 3792014 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 3792014 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 3792014 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@37692a6e{/,null,AVAILABLE}
[junit4] 2> 3792015 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@22d102b{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:34191}
[junit4] 2> 3792015 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.Server Started @3792047ms
[junit4] 2> 3792015 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=34191, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard2/cores}
[junit4] 2> 3792015 ERROR (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 3792015 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 3792015 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.9.0
[junit4] 2> 3792015 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 3792015 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr
[junit4] 2> 3792015 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-05-18T14:32:43.557Z
[junit4] 2> 3792015 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard2/solr.xml
[junit4] 2> 3792017 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 3792017 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 3792019 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@970ace, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 3792226 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 3792227 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@423e93e3[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3792227 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@423e93e3[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3792229 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@297fdc2e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3792230 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@297fdc2e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3792231 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] 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> 3792242 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 3792242 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 3792262 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@970ace
[junit4] 2> 3792274 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@970ace
[junit4] 2> 3792274 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@970ace
[junit4] 2> 3792276 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard2/cores
[junit4] 2> 3792276 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 3792283 INFO (coreLoadExecutor-33168-thread-1) [ x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 3792301 INFO (coreLoadExecutor-33168-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
[junit4] 2> 3792301 WARN (coreLoadExecutor-33168-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
[junit4] 2> 3792302 WARN (coreLoadExecutor-33168-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> 3792305 INFO (coreLoadExecutor-33168-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 3792312 INFO (coreLoadExecutor-33168-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 3792318 INFO (coreLoadExecutor-33168-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 3792319 INFO (coreLoadExecutor-33168-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@970ace
[junit4] 2> 3792319 INFO (coreLoadExecutor-33168-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard2/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard2/cores/collection1/data/]
[junit4] 2> 3792320 INFO (coreLoadExecutor-33168-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=39, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=0.390625, floorSegmentMB=0.7001953125, forceMergeDeletesPctAllowed=5.636554578242614, segmentsPerTier=30.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6756015100032812, deletesPctAllowed=33.36388246444841
[junit4] 2> 3792394 INFO (coreLoadExecutor-33168-thread-1) [ x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 3792394 INFO (coreLoadExecutor-33168-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 3792395 INFO (coreLoadExecutor-33168-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 3792395 INFO (coreLoadExecutor-33168-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 3792396 INFO (coreLoadExecutor-33168-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=33, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=44.52734375, floorSegmentMB=2.130859375, forceMergeDeletesPctAllowed=29.957515355984143, segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0, deletesPctAllowed=45.3085316640974
[junit4] 2> 3792397 INFO (coreLoadExecutor-33168-thread-1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 3792412 INFO (coreLoadExecutor-33168-thread-1) [ x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 3792472 INFO (coreLoadExecutor-33168-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 3792472 INFO (coreLoadExecutor-33168-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1700106982144344064
[junit4] 2> 3792473 INFO (searcherExecutor-33170-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 3792473 INFO (searcherExecutor-33170-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 3792473 INFO (searcherExecutor-33170-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 3792473 INFO (searcherExecutor-33170-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 3792473 INFO (searcherExecutor-33170-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 3792474 INFO (searcherExecutor-33170-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 3792474 INFO (searcherExecutor-33170-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 3792474 INFO (searcherExecutor-33170-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 3792474 INFO (searcherExecutor-33170-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 3792476 INFO (searcherExecutor-33170-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 3793077 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard3/cores/collection1
[junit4] 2> 3793078 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 3793078 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 3793078 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_281-b09
[junit4] 2> 3793079 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 3793079 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 3793079 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 3793079 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@24826359{/,null,AVAILABLE}
[junit4] 2> 3793080 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@71afb415{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:34847}
[junit4] 2> 3793080 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.Server Started @3793112ms
[junit4] 2> 3793080 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=34847, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard3/cores}
[junit4] 2> 3793080 ERROR (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 3793080 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 3793080 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.9.0
[junit4] 2> 3793080 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 3793080 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr
[junit4] 2> 3793080 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-05-18T14:32:44.622Z
[junit4] 2> 3793080 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard3/solr.xml
[junit4] 2> 3793083 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 3793083 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 3793084 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@970ace, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 3793785 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 3793786 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@1e3de6c0[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3793786 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@1e3de6c0[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3793789 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@1d49b7d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3793789 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@1d49b7d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3793791 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] 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> 3793801 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 3793801 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 3793822 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@970ace
[junit4] 2> 3793833 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@970ace
[junit4] 2> 3793833 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@970ace
[junit4] 2> 3793835 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard3/cores
[junit4] 2> 3793835 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 3793842 INFO (coreLoadExecutor-33187-thread-1) [ x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 3793873 INFO (coreLoadExecutor-33187-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
[junit4] 2> 3793873 WARN (coreLoadExecutor-33187-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
[junit4] 2> 3793873 WARN (coreLoadExecutor-33187-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> 3793876 INFO (coreLoadExecutor-33187-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 3793883 INFO (coreLoadExecutor-33187-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 3793890 INFO (coreLoadExecutor-33187-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 3793890 INFO (coreLoadExecutor-33187-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@970ace
[junit4] 2> 3793890 INFO (coreLoadExecutor-33187-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard3/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard3/cores/collection1/data/]
[junit4] 2> 3793891 INFO (coreLoadExecutor-33187-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=39, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=0.390625, floorSegmentMB=0.7001953125, forceMergeDeletesPctAllowed=5.636554578242614, segmentsPerTier=30.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6756015100032812, deletesPctAllowed=33.36388246444841
[junit4] 2> 3793945 INFO (coreLoadExecutor-33187-thread-1) [ x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 3793945 INFO (coreLoadExecutor-33187-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 3793946 INFO (coreLoadExecutor-33187-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 3793946 INFO (coreLoadExecutor-33187-thread-1) [ x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 3793947 INFO (coreLoadExecutor-33187-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=33, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=44.52734375, floorSegmentMB=2.130859375, forceMergeDeletesPctAllowed=29.957515355984143, segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0, deletesPctAllowed=45.3085316640974
[junit4] 2> 3793948 INFO (coreLoadExecutor-33187-thread-1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 3793964 INFO (coreLoadExecutor-33187-thread-1) [ x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 3794023 INFO (coreLoadExecutor-33187-thread-1) [ x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 3794023 INFO (coreLoadExecutor-33187-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1700106983770685440
[junit4] 2> 3794024 INFO (searcherExecutor-33189-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 3794025 INFO (searcherExecutor-33189-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 3794025 INFO (searcherExecutor-33189-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 3794025 INFO (searcherExecutor-33189-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 3794025 INFO (searcherExecutor-33189-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 3794025 INFO (searcherExecutor-33189-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 3794025 INFO (searcherExecutor-33189-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 3794025 INFO (searcherExecutor-33189-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 3794025 INFO (searcherExecutor-33189-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 3794027 INFO (searcherExecutor-33189-thread-1-processing-x:collection1) [ x:collection1 ] o.a.s.c.SolrCore [collection1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 3794629 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard4/cores/collection1
[junit4] 2> 3794630 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 3794630 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 3794630 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_281-b09
[junit4] 2> 3794631 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 3794631 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 3794631 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 3794631 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3dbd3531{/,null,AVAILABLE}
[junit4] 2> 3794631 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@6bee4c03{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:44129}
[junit4] 2> 3794631 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.s.Server Started @3794663ms
[junit4] 2> 3794631 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=44129, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard4/cores}
[junit4] 2> 3794631 ERROR (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 3794631 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 3794631 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.9.0
[junit4] 2> 3794631 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 3794631 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr
[junit4] 2> 3794632 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-05-18T14:32:46.174Z
[junit4] 2> 3794632 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard4/solr.xml
[junit4] 2> 3794634 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 3794634 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 3794638 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@970ace, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 3796314 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 3796315 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@65ce6518[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3796315 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@65ce6518[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3796318 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@557bff20[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3796318 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@557bff20[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 3796319 WARN (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] 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> 3796331 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 3796331 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 3796353 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@970ace
[junit4] 2> 3796366 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@970ace
[junit4] 2> 3796366 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@970ace
[junit4] 2> 3796368 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard4/cores
[junit4] 2> 3796368 INFO (TEST-TestDistributedStatsComponentCardinality.test-seed#[C34B1B8865B43E92]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 3796375 INFO (coreLoadExecutor-33206-thread-1) [ x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 3796405 INFO (coreLoadExecutor-33206-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
[junit4] 2> 3796405 WARN (coreLoadExecutor-33206-thread-1) [ x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
[junit4] 2> 3796405 WARN (coreLoadExecutor-33206-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> 3796408 INFO (coreLoadExecutor-33206-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 3796415 INFO (coreLoadExecutor-33206-thread-1) [ x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 3796422 INFO (coreLoadExecutor-33206-thread-1) [ x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 3796422 INFO (coreLoadExecutor-33206-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@970ace
[junit4] 2> 3796422 INFO (coreLoadExecutor-33206-thread-1) [ x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard4/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.component.TestDistributedStatsComponentCardinality_C34B1B8865B43E92-001/tempDir-001/shard4/cores/collection1/data/]
[junit4] 2> 3796424 INFO (coreLoadExecutor-33206-thread-1) [ x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=39, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=0.390625, floorSegmentMB=0.7001953125, forceMergeDeletesPctAllowed=5.636554578242614, segmentsPerTier=30.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6756015100032812, deletesPctAllowed=33.36388246444841
[junit4] 2> 3796479 INFO (coreLoadExecutor-33206-thread-1) [ x:collection1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 3796479 INFO (coreLoadExecutor-33206-thread-1) [ x:collection1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 3796480 INFO (coreLoadExecutor-3320
[...truncated too long message...]
thread-6) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 4023187 INFO (closeThreadPool-33258-thread-6) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@183da636: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@71e70da3
[junit4] 2> 4023191 INFO (closeThreadPool-33258-thread-6) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@3899d07e{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 4023191 INFO (closeThreadPool-33258-thread-6) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@3964fa60{/,null,STOPPED}
[junit4] 2> 4023191 INFO (closeThreadPool-33258-thread-6) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> NOTE: download the large Jenkins line-docs file by running 'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestDistributedStatsComponentCardinality -Dtests.method=test -Dtests.seed=C34B1B8865B43E92 -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-NightlyTests-8.x/test-data/enwiki.random.lines.txt -Dtests.locale=ga -Dtests.timezone=Europe/Volgograd -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 234s J1 | TestDistributedStatsComponentCardinality.test <<<
[junit4] > Throwable #1: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=211234, name=Thread-164431, state=RUNNABLE, group=TGRP-TestDistributedStatsComponentCardinality]
[junit4] > at __randomizedtesting.SeedInfo.seed([C34B1B8865B43E92:4B1F2452CB48536A]:0)
[junit4] > Caused by: junit.framework.AssertionFailedError: .responseHeader.status:200!=0
[junit4] > at __randomizedtesting.SeedInfo.seed([C34B1B8865B43E92]:0)
[junit4] > at junit.framework.Assert.fail(Assert.java:57)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase.compareSolrResponses(BaseDistributedSearchTestCase.java:1006)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase.compareResponses(BaseDistributedSearchTestCase.java:1033)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$5.run(BaseDistributedSearchTestCase.java:694)
[junit4] 2> 4023195 INFO (SUITE-TestDistributedStatsComponentCardinality-seed#[C34B1B8865B43E92]-worker) [ ] o.a.s.SolrTestCaseJ4 ------------------------------------------------------- Done waiting for tracked resources to be released
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene87): {multiDefault=BlockTreeOrds(blocksize=128), _root_=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), string_s=PostingsFormat(name=LuceneFixedGap), id=PostingsFormat(name=MockRandom)}, docValues:{int_i=DocValuesFormat(name=Lucene80), range_facet_l_dv=DocValuesFormat(name=Lucene80), intDefault=DocValuesFormat(name=Direct), int_i_prehashed_l=DocValuesFormat(name=Lucene80), range_facet_l=DocValuesFormat(name=Asserting), long_l_prehashed_l=DocValuesFormat(name=Lucene80), long_l=DocValuesFormat(name=Lucene80), _version_=DocValuesFormat(name=Direct), string_s_prehashed_l=DocValuesFormat(name=Lucene80), id_i1=DocValuesFormat(name=Direct), range_facet_i_dv=DocValuesFormat(name=Asserting), intDvoDefault=DocValuesFormat(name=Lucene80), timestamp=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=2014, maxMBSortInHeap=5.702635516556694, sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=ga, timezone=Europe/Volgograd
[junit4] 2> NOTE: Linux 4.15.0-142-generic amd64/Oracle Corporation 1.8.0_281 (64-bit)/cpus=4,threads=1,free=156543880,total=529530880
[junit4] 2> NOTE: All tests run in this JVM: [TestQueryUtils, TolerantUpdateProcessorTest, CheckHdfsIndexTest, TestTolerantUpdateProcessorCloud, ZkFailoverTest, DistributedFacetPivotLargeTest, MetricsHistoryWithAuthIntegrationTest, ReplicationFactorTest, HdfsSyncSliceTest, TestRandomRequestDistribution, BlockJoinFacetSimpleTest, TestPullReplicaErrorHandling, VersionInfoTest, ProtectedTermFilterFactoryTest, TestPKIAuthenticationPlugin, TestSQLHandlerNonCloud, RoutingToNodesWithPropertiesTest, ExternalFileFieldSortTest, CdcrBidirectionalTest, TestFieldCacheWithThreads, TestAnalyzeInfixSuggestions, TestComplexPhraseQParserPlugin, HLLUtilTest, TestSimExecutePlanAction, LeaderElectionIntegrationTest, TestStressInPlaceUpdates, TestNestedDocsSort, DirectSolrConnectionTest, RequiredFieldsTest, RegexBoostProcessorTest, ZkStateReaderTest, TestSimClusterStateProvider, TestJsonRequest, TestSimTriggerIntegration, CopyFieldTest, CoreAdminRequestStatusTest, JavaBinAtomicUpdateMultivalueTest, TestRTimerTree, TestUninvertingReader, TestUniqueKeyFieldResource, XmlInterpolationTest, TestPayloadCheckQParserPlugin, DataDrivenBlockJoinTest, SyncSliceTest, SuggesterFSTTest, TestCustomDocTransformer, TestSolrDeletionPolicy2, DocValuesNotIndexedTest, ShardRoutingTest, TestLocalFSCloudBackupRestore, MoreLikeThisHandlerTest, NotRequiredUniqueKeyTest, HttpPartitionOnCommitTest, TestRetrieveFieldsOptimizer, TestBlobHandler, DebugComponentTest, DOMUtilTest, TestPHPSerializedResponseWriter, TestConfigSetProperties, MoveReplicaHDFSTest, UtilsToolTest, TestSolrCachePerf, CdcrRequestHandlerTest, IndexSizeTriggerTest, TestLRUCache, TestNumericRangeQuery32, TestExceedMaxTermLength, TestJmxIntegration, PreAnalyzedFieldManagedSchemaCloudTest, CollectionsAPISolrJTest, AutoscalingHistoryHandlerTest, NodeAddedTriggerTest, TriggerCooldownIntegrationTest, TestStressRecovery, TestConfLoadPerf, NestedShardedAtomicUpdateTest, TestMiniSolrCloudClusterSSL, SpatialRPTFieldTypeTest, SolrShardReporterTest, ChaosMonkeyNothingIsSafeTest, TestCloudDeleteByQuery, TestBooleanSimilarityFactory, TestClusterProperties, FacetPivotSmallTest, PeerSyncTest, TestReversedWildcardFilterFactory, BadComponentTest, HdfsWriteToMultipleCollectionsTest, TestSolrCloudWithDelegationTokens, LocalFSCloudIncrementalBackupTest, TestHashQParserPlugin, TestSimNodeAddedTrigger, TestStressIncrementalBackup, AutoAddReplicasPlanActionTest, PKIAuthenticationIntegrationTest, TestExportTool, HdfsDirectoryFactoryTest, TestNonDefinedSimilarityFactory, TestCloudPseudoReturnFields, SolrCoreTest, TestFaceting, TestShardHandlerFactory, TestHalfAndHalfDocValues, AssignTest, TestSchemalessBufferedUpdates, HdfsBasicDistributedZk2Test, BlockCacheTest, CreateRoutedAliasTest, DistributedQueryElevationComponentTest, TestExplainDocTransformer, CoreSorterTest, TestUpdate, TestHashPartitioner, DistanceFunctionTest, V2StandaloneTest, AnalysisAfterCoreReloadTest, BasicFunctionalityTest, ConvertedLegacyTest, CursorPagingTest, DisMaxRequestHandlerTest, DistributedIntervalFacetingTest, EchoParamsTest, MinimalSchemaTest, OutputWriterTest, SampleTest, SolrInfoBeanTest, SolrTestCaseJ4DeleteCoreTest, SolrTestCaseJ4Test, TestCrossCoreJoin, TestCursorMarkWithoutUniqueKey, TestDistributedMissingSort, TestDistributedSearch, TestDocumentBuilder, TestHighlightDedupGrouping, TestJoin, TestRandomDVFaceting, TestSimpleTrackingShardHandler, TestSolrCoreProperties, TestTolerantSearch, TokenizerChainTest, TestLuceneIndexBackCompat, TestEmbeddedSolrServerAdminHandler, TestEmbeddedSolrServerConstructors, TestJettySolrRunner, ConnectionReuseTest, ActionThrottleTest, AliasIntegrationTest, BasicDistributedZkTest, DeleteNodeTest, DeleteShardTest, DistribCursorPagingTest, DistribDocExpirationUpdateProcessorTest, LeaderTragicEventTest, LeaderVoteWaitTimeoutTest, PackageManagerCLITest, RecoveryAfterSoftCommitTest, RecoveryZkTest, RemoteQueryErrorTest, ReplaceNodeNoTargetTest, SaslZkACLProviderTest, SharedFSAutoReplicaFailoverTest, SliceStateTest, SolrCLIZkUtilsTest, SolrCloudExampleTest, TestConfigSetsAPIZkFailure, TestCryptoKeys, TestDeleteCollectionOnDownNodes, TestDistribDocBasedVersion, TestQueryingOnDownCollection, TestRequestForwarding, TestSSLRandomization, TestSizeLimitedDistributedMap, TlogReplayBufferedWhileIndexingTest, ConcurrentCreateCollectionTest, ConcurrentDeleteAndCreateCollectionTest, SplitByPrefixTest, TestCollectionsAPIViaSolrCloudCluster, ComputePlanActionTest, HttpTriggerListenerTest, MetricTriggerTest, NodeMarkersRegistrationTest, RestoreTriggerStateTest, ScheduledMaintenanceTriggerTest, ScheduledTriggerIntegrationTest, SearchRateTriggerIntegrationTest, HdfsChaosMonkeyNothingIsSafeTest, HdfsChaosMonkeySafeLeaderTest, ZkDynamicConfigTest, BlobRepositoryCloudTest, ByteBuffersDirectoryFactoryTest, CachingDirectoryFactoryTest, TestDynamicLoadingUrl, TestQuerySenderListener, TestXIncludeConfig, BackupIdTest, TestSolrCoreSnapshots, BinaryUpdateRequestHandlerTest, CSVRequestHandlerTest, DocumentAnalysisRequestHandlerTest, TestContainerPlugin, TestIncrementalCoreBackup, TestReplicationHandlerBackup, TestReplicationHandlerDiskOverFlow, TestReqParamsAPI, TestRestoreCore, TestSolrConfigHandlerCloud, CoreAdminHandlerTest, HealthCheckHandlerTest, IndexSizeEstimatorTest, InfoHandlerTest, LoggingHandlerTest, LukeRequestHandlerTest, MBeansHandlerTest, MetricsHandlerTest, PropertiesRequestHandlerTest, SecurityConfHandlerTest, SegmentsInfoRequestHandlerTest, SplitHandlerTest, StatsReloadRaceTest, TestApiFramework, TestCollectionAPIs, TestConfigsApi, TestCoreAdminApis, ThreadDumpHandlerTest, V2CollectionBackupsAPIMappingTest, ZookeeperReadAPITest, CustomHighlightComponentTest, DistributedFacetPivotSmallTest, DistributedFacetPivotWhiteBoxTest, DistributedMLTComponentTest, DistributedQueryComponentCustomSortTest, PhrasesIdentificationComponentTest, QueryElevationComponentTest, ResponseBuilderTest, SearchHandlerTest, ShardsWhitelistTest, StatsComponentTest, TermVectorComponentDistributedTest, TestDistributedStatsComponentCardinality]
[junit4] Completed [650/939 (1!)] on J1 in 235.15s, 1 test, 1 error <<< FAILURES!
[...truncated 51833 lines...]