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/02/13 22:19:51 UTC
[JENKINS] Lucene » Lucene-Solr-Tests-8.8 - Build # 271 - Unstable!
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.8/271/
1 tests failed.
FAILED: org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest.testHistory
Error Message:
action did not execute
Stack Trace:
java.lang.AssertionError: action did not execute
at __randomizedtesting.SeedInfo.seed([DA322DB11A8FDEC3:B7CE894CA0C721C4]:0)
at org.junit.Assert.fail(Assert.java:89)
at org.junit.Assert.assertTrue(Assert.java:42)
at org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest.testHistory(AutoscalingHistoryHandlerTest.java:283)
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)
Build Log:
[...truncated 13376 lines...]
[junit4] Suite: org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest
[junit4] 2> 90697 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[DA322DB11A8FDEC3]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/server/solr/configsets/_default/conf'
[junit4] 2> 90697 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[DA322DB11A8FDEC3]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 90698 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[DA322DB11A8FDEC3]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_DA322DB11A8FDEC3-001/data-dir-7-001
[junit4] 2> 90698 WARN (SUITE-AutoscalingHistoryHandlerTest-seed#[DA322DB11A8FDEC3]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=22 numCloses=22
[junit4] 2> 90698 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[DA322DB11A8FDEC3]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 90700 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[DA322DB11A8FDEC3]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 90700 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[DA322DB11A8FDEC3]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_DA322DB11A8FDEC3-001/tempDir-001
[junit4] 2> 90700 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[DA322DB11A8FDEC3]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 90700 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 90700 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 90703 WARN (ZkTestServer Run Thread) [ ] o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
[junit4] 2> 90938 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[DA322DB11A8FDEC3]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port: 36151
[junit4] 2> 90938 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[DA322DB11A8FDEC3]-worker) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:36151
[junit4] 2> 90938 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[DA322DB11A8FDEC3]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:36151
[junit4] 2> 90938 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[DA322DB11A8FDEC3]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 36151
[junit4] 2> 90985 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[DA322DB11A8FDEC3]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 91008 INFO (zkConnectionManagerCallback-987-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 91008 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[DA322DB11A8FDEC3]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 91079 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[DA322DB11A8FDEC3]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 91096 INFO (zkConnectionManagerCallback-989-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 91096 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[DA322DB11A8FDEC3]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 91103 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[DA322DB11A8FDEC3]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 91120 INFO (zkConnectionManagerCallback-991-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 91120 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[DA322DB11A8FDEC3]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 91402 INFO (jetty-launcher-992-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 91402 INFO (jetty-launcher-992-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 91402 INFO (jetty-launcher-992-thread-2) [ ] 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> 91403 INFO (jetty-launcher-992-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 91403 INFO (jetty-launcher-992-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 91403 INFO (jetty-launcher-992-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> 91514 INFO (jetty-launcher-992-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 91514 INFO (jetty-launcher-992-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 91514 INFO (jetty-launcher-992-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 91537 INFO (jetty-launcher-992-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@49be3adb{/solr,null,AVAILABLE}
[junit4] 2> 91545 INFO (jetty-launcher-992-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 91546 INFO (jetty-launcher-992-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 91546 INFO (jetty-launcher-992-thread-2) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 91546 INFO (jetty-launcher-992-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@11482a9a{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:38213}
[junit4] 2> 91546 INFO (jetty-launcher-992-thread-1) [ ] o.e.j.s.Server Started @91575ms
[junit4] 2> 91546 INFO (jetty-launcher-992-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, zkHost=127.0.0.1:36151/solr, hostPort=38213}
[junit4] 2> 91546 ERROR (jetty-launcher-992-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 91546 INFO (jetty-launcher-992-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 91546 INFO (jetty-launcher-992-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.8.1
[junit4] 2> 91546 INFO (jetty-launcher-992-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 91546 INFO (jetty-launcher-992-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr
[junit4] 2> 91546 INFO (jetty-launcher-992-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-02-13T21:23:49.566Z
[junit4] 2> 91556 INFO (jetty-launcher-992-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3b7efa08{/solr,null,AVAILABLE}
[junit4] 2> 91580 INFO (jetty-launcher-992-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 91580 INFO (jetty-launcher-992-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@2af85163{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:38239}
[junit4] 2> 91580 INFO (jetty-launcher-992-thread-2) [ ] o.e.j.s.Server Started @91609ms
[junit4] 2> 91580 INFO (jetty-launcher-992-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, zkHost=127.0.0.1:36151/solr, hostPort=38239}
[junit4] 2> 91580 ERROR (jetty-launcher-992-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 91580 INFO (jetty-launcher-992-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 91580 INFO (jetty-launcher-992-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.8.1
[junit4] 2> 91580 INFO (jetty-launcher-992-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 91580 INFO (jetty-launcher-992-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr
[junit4] 2> 91580 INFO (jetty-launcher-992-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-02-13T21:23:49.600Z
[junit4] 2> 91734 INFO (zkConnectionManagerCallback-994-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 91734 INFO (jetty-launcher-992-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 91735 INFO (jetty-launcher-992-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 91754 INFO (jetty-launcher-992-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 91755 WARN (jetty-launcher-992-thread-1-SendThread(127.0.0.1:36151)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x103543233be0003.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x103543233be0003, 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 0x103543233be0003, 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> 91764 INFO (zkConnectionManagerCallback-996-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 91764 INFO (jetty-launcher-992-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 91856 INFO (jetty-launcher-992-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 91860 WARN (jetty-launcher-992-thread-2-SendThread(127.0.0.1:36151)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x103543233be0004.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x103543233be0004, 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 0x103543233be0004, 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> 93050 INFO (jetty-launcher-992-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 93051 WARN (jetty-launcher-992-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@45782930[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 93051 WARN (jetty-launcher-992-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@45782930[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 93277 WARN (jetty-launcher-992-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@5a0b129f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 93277 WARN (jetty-launcher-992-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@5a0b129f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 93278 INFO (jetty-launcher-992-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36151/solr
[junit4] 2> 93279 INFO (jetty-launcher-992-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 93359 INFO (zkConnectionManagerCallback-1010-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 93359 INFO (jetty-launcher-992-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 93462 INFO (jetty-launcher-992-thread-2) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 93465 INFO (zkConnectionManagerCallback-1012-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 93465 INFO (jetty-launcher-992-thread-2) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 93495 INFO (jetty-launcher-992-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 93497 WARN (jetty-launcher-992-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@4d121804[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 93497 WARN (jetty-launcher-992-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@4d121804[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 93501 WARN (jetty-launcher-992-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@22b65562[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 93501 WARN (jetty-launcher-992-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@22b65562[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 93502 INFO (jetty-launcher-992-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36151/solr
[junit4] 2> 93503 INFO (jetty-launcher-992-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 93509 INFO (zkConnectionManagerCallback-1022-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 93509 INFO (jetty-launcher-992-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 93551 INFO (jetty-launcher-992-thread-2) [n:127.0.0.1:38239_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:38239_solr
[junit4] 2> 93551 INFO (jetty-launcher-992-thread-2) [n:127.0.0.1:38239_solr ] o.a.s.c.Overseer Overseer (id=72994593561247750-127.0.0.1:38239_solr-n_0000000000) starting
[junit4] 2> 93556 INFO (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:38239_solr
[junit4] 2> 93557 INFO (jetty-launcher-992-thread-2) [n:127.0.0.1:38239_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:38239_solr
[junit4] 2> 93559 INFO (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 93560 INFO (jetty-launcher-992-thread-2) [n:127.0.0.1:38239_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 93560 DEBUG (OverseerAutoScalingTriggerThread-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and .scheduled_maintenance triggers
[junit4] 2> 93561 WARN (jetty-launcher-992-thread-2) [n:127.0.0.1:38239_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> 93565 DEBUG (OverseerAutoScalingTriggerThread-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1
[junit4] 2> 93567 DEBUG (OverseerAutoScalingTriggerThread-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 0
[junit4] 2> 93567 DEBUG (OverseerAutoScalingTriggerThread-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
[junit4] 2> 93575 INFO (jetty-launcher-992-thread-2) [n:127.0.0.1:38239_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 93579 DEBUG (OverseerAutoScalingTriggerThread-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial livenodes: [127.0.0.1:38239_solr]
[junit4] 2> 93601 DEBUG (ScheduledTrigger-1025-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 and last live nodes: 1
[junit4] 2> 93602 DEBUG (OverseerAutoScalingTriggerThread-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded markers
[junit4] 2> 93616 INFO (jetty-launcher-992-thread-1) [n:127.0.0.1:38213_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 93615 INFO (jetty-launcher-992-thread-2) [n:127.0.0.1:38239_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38239.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@63b1b954
[junit4] 2> 93617 DEBUG (OverseerAutoScalingTriggerThread-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
[junit4] 2> 93623 INFO (jetty-launcher-992-thread-2) [n:127.0.0.1:38239_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38239.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@63b1b954
[junit4] 2> 93623 INFO (jetty-launcher-992-thread-2) [n:127.0.0.1:38239_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38239.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@63b1b954
[junit4] 2> 93624 INFO (zkConnectionManagerCallback-1033-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 93624 INFO (jetty-launcher-992-thread-1) [n:127.0.0.1:38213_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 93624 INFO (jetty-launcher-992-thread-2) [n:127.0.0.1:38239_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_DA322DB11A8FDEC3-001/tempDir-001/node1
[junit4] 2> 93629 INFO (jetty-launcher-992-thread-1) [n:127.0.0.1:38213_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 93632 INFO (jetty-launcher-992-thread-1) [n:127.0.0.1:38213_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:38213_solr as DOWN
[junit4] 2> 93633 INFO (jetty-launcher-992-thread-1) [n:127.0.0.1:38213_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 93633 INFO (jetty-launcher-992-thread-1) [n:127.0.0.1:38213_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:38213_solr
[junit4] 2> 93637 INFO (jetty-launcher-992-thread-1) [n:127.0.0.1:38213_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 93638 WARN (jetty-launcher-992-thread-1) [n:127.0.0.1:38213_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> 93645 INFO (zkCallback-1011-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 93645 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"downnode",
[junit4] 2> "node_name":"127.0.0.1:38213_solr"} current state version: 0
[junit4] 2> 93645 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 127.0.0.1:38213_solr
[junit4] 2> 93645 INFO (zkCallback-1032-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 93652 INFO (jetty-launcher-992-thread-1) [n:127.0.0.1:38213_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 93671 INFO (jetty-launcher-992-thread-1) [n:127.0.0.1:38213_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38213.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@63b1b954
[junit4] 2> 93744 INFO (jetty-launcher-992-thread-1) [n:127.0.0.1:38213_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38213.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@63b1b954
[junit4] 2> 93744 INFO (jetty-launcher-992-thread-1) [n:127.0.0.1:38213_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38213.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@63b1b954
[junit4] 2> 93745 INFO (jetty-launcher-992-thread-1) [n:127.0.0.1:38213_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_DA322DB11A8FDEC3-001/tempDir-001/node2
[junit4] 2> 93761 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[DA322DB11A8FDEC3]-worker) [ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2
[junit4] 2> 93762 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[DA322DB11A8FDEC3]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 93763 INFO (zkConnectionManagerCallback-1047-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 93763 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[DA322DB11A8FDEC3]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 93765 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[DA322DB11A8FDEC3]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 93767 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[DA322DB11A8FDEC3]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:36151/solr ready
[junit4] 2> 93782 INFO (OverseerThreadFactory-1027-thread-1-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection .system
[junit4] 2> 93792 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "name":".system",
[junit4] 2> "fromApi":"true",
[junit4] 2> "numShards":1,
[junit4] 2> "createNodeSet":"127.0.0.1:38239_solr",
[junit4] 2> "nrtReplicas":"1",
[junit4] 2> "stateFormat":"2",
[junit4] 2> "replicationFactor":"1",
[junit4] 2> "operation":"create"} current state version: 0
[junit4] 2> 93792 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.ClusterStateMutator building a new cName: .system
[junit4] 2> 93793 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/.system/state.json
[junit4] 2> 93920 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":".system",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:38239_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 93920 INFO (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":".system",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:38239_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 93921 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{}}
[junit4] 2> 93921 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node2":{
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:38239_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "base_url":"http://127.0.0.1:38239/solr"}}}
[junit4] 2> 94025 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 0
[junit4] 2> 94129 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr x:.system_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node2&collection.configName=.system&newCollection=true&name=.system_shard1_replica_n1&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 94129 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr x:.system_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 94138 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node2",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:38239_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":".system",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 94138 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node2",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:38239_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":".system",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"}
[junit4] 2> 94139 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node2:{
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:38239_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "base_url":"http://127.0.0.1:38239/solr"}
[junit4] 2> 94139 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(.system//collections/.system/state.json/1 )={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"1",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"1",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"1",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node2":{
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:38239_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "base_url":"http://127.0.0.1:38239/solr"}}}}}
[junit4] 2> 94147 WARN (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SolrConfig You should not use LATEST as luceneMatchVersion property: if you use this setting, and then Solr upgrades to a newer release of Lucene, sizable changes may happen. If precise back compatibility is important then you should instead explicitly specify an actual Lucene version.
[junit4] 2> 94147 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.8.1
[junit4] 2> 94152 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed, but managed schema resource managed-schema not found - loading non-managed schema schema.xml instead
[junit4] 2> 94155 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema name=_system collection or core
[junit4] 2> 94156 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema _system collection or core/1.1 with uniqueid field id
[junit4] 2> 94168 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Created and persisted managed schema znode at /configs/.system/managed-schema
[junit4] 2> 94172 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema in ZooKeeper, renamed the non-managed schema /configs/.system/schema.xml to /configs/.system/schema.xml.bak
[junit4] 2> 94173 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore '.system_shard1_replica_n1' using configuration from configset .system, trusted=true
[junit4] 2> 94173 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38239.solr.core..system.shard1.replica_n1' (registry 'solr.core..system.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@63b1b954
[junit4] 2> 94173 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SolrCore [[.system_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_DA322DB11A8FDEC3-001/tempDir-001/node1/.system_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_DA322DB11A8FDEC3-001/tempDir-001/node1/.system_shard1_replica_n1/data/]
[junit4] 2> 94227 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 94227 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 94228 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: if 1 uncommitted docs;
[junit4] 2> 94228 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 94231 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/.system
[junit4] 2> 94231 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/.system
[junit4] 2> 94231 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/.system/managed-schema
[junit4] 2> 94232 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 94232 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 94233 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1691616733826121728
[junit4] 2> 94327 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 1
[junit4] 2> 94340 INFO (searcherExecutor-1049-thread-1-processing-n:127.0.0.1:38239_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node2) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SolrCore [.system_shard1_replica_n1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 94345 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/.system/terms/shard1 to Terms{values={core_node2=0}, version=0}
[junit4] 2> 94345 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/.system/leaders/shard1
[junit4] 2> 94350 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 94350 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 94350 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:38239/solr/.system_shard1_replica_n1/
[junit4] 2> 94351 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 94351 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SyncStrategy http://127.0.0.1:38239/solr/.system_shard1_replica_n1/ has no replicas
[junit4] 2> 94351 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/.system/leaders/shard1/leader after winning as /collections/.system/leader_elect/shard1/election/72994593561247750-core_node2-n_0000000000
[junit4] 2> 94359 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:38239/solr/.system_shard1_replica_n1/ shard1
[junit4] 2> 94359 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":".system",
[junit4] 2> "node_name":"127.0.0.1:38239_solr",
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "state":"active"} current state version: 0
[junit4] 2> 94459 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 2
[junit4] 2> 94460 INFO (zkCallback-1011-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [2])
[junit4] 2> 94460 INFO (zkCallback-1011-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [2])
[junit4] 2> 94464 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 94466 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node2",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:38239_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":".system",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 94466 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node2",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:38239_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":".system",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"}
[junit4] 2> 94466 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node2:{
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:38239_solr",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "leader":"true",
[junit4] 2> "base_url":"http://127.0.0.1:38239/solr"}
[junit4] 2> 94466 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(.system//collections/.system/state.json/3 )={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"1",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"1",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"1",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node2":{
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:38239_solr",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "leader":"true",
[junit4] 2> "base_url":"http://127.0.0.1:38239/solr"}}}}}
[junit4] 2> 94468 INFO (qtp608152468-1445) [n:127.0.0.1:38239_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=.system&newCollection=true&name=.system_shard1_replica_n1&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=339
[junit4] 2> 94470 INFO (qtp608152468-1440) [n:127.0.0.1:38239_solr ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 94613 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 3
[junit4] 2> 94613 INFO (zkCallback-1011-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [2])
[junit4] 2> 94613 INFO (zkCallback-1011-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [2])
[junit4] 2> 94614 INFO (qtp608152468-1440) [n:127.0.0.1:38239_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={name=.system&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:38239_solr&wt=javabin&version=2} status=0 QTime=840
[junit4] 2> 94614 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[DA322DB11A8FDEC3]-worker) [ ] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection: .system
[junit4] 2> 94619 INFO (zkCallback-1011-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [2])
[junit4] 2> 94621 DEBUG (ScheduledTrigger-1025-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 1
[junit4] 2> 94630 INFO (OverseerCollectionConfigSetProcessor-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 94630 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection AutoscalingHistoryHandlerTest_collection
[junit4] 2> 94630 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED
[junit4] 2> 94631 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/protwords.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/protwords.txt
[junit4] 2> 94633 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/managed-schema to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/managed-schema
[junit4] 2> 94635 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/solrconfig.xml to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/solrconfig.xml
[junit4] 2> 94637 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_it.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/contractions_it.txt
[junit4] 2> 94638 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_no.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_no.txt
[junit4] 2> 94640 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_ca.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/contractions_ca.txt
[junit4] 2> 94641 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stemdict_nl.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stemdict_nl.txt
[junit4] 2> 94643 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hy.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_hy.txt
[junit4] 2> 94645 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_id.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_id.txt
[junit4] 2> 94646 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_et.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_et.txt
[junit4] 2> 94648 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ga.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ga.txt
[junit4] 2> 94649 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_da.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_da.txt
[junit4] 2> 94650 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hi.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_hi.txt
[junit4] 2> 94652 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ja.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ja.txt
[junit4] 2> 94653 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_pt.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_pt.txt
[junit4] 2> 94654 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hu.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_hu.txt
[junit4] 2> 94656 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_el.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_el.txt
[junit4] 2> 94657 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ru.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ru.txt
[junit4] 2> 94658 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_tr.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_tr.txt
[junit4] 2> 94659 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ar.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ar.txt
[junit4] 2> 94661 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/userdict_ja.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/userdict_ja.txt
[junit4] 2> 94662 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_it.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_it.txt
[junit4] 2> 94664 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_eu.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_eu.txt
[junit4] 2> 94667 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_cz.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_cz.txt
[junit4] 2> 94668 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stoptags_ja.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stoptags_ja.txt
[junit4] 2> 94670 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_fr.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/contractions_fr.txt
[junit4] 2> 94672 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_de.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_de.txt
[junit4] 2> 94675 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fa.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_fa.txt
[junit4] 2> 94683 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_ga.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/contractions_ga.txt
[junit4] 2> 94685 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ca.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ca.txt
[junit4] 2> 94687 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_nl.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_nl.txt
[junit4] 2> 94689 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_bg.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_bg.txt
[junit4] 2> 94691 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_en.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_en.txt
[junit4] 2> 94693 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_lv.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_lv.txt
[junit4] 2> 94694 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_es.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_es.txt
[junit4] 2> 94696 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_th.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_th.txt
[junit4] 2> 94700 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ro.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ro.txt
[junit4] 2> 94703 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fr.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_fr.txt
[junit4] 2> 94705 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_sv.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_sv.txt
[junit4] 2> 94707 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fi.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_fi.txt
[junit4] 2> 94709 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/hyphenations_ga.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/hyphenations_ga.txt
[junit4] 2> 94712 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_gl.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_gl.txt
[junit4] 2> 94714 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/synonyms.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/synonyms.txt
[junit4] 2> 94715 INFO (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/stopwords.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/stopwords.txt
[junit4] 2> 94720 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "name":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "fromApi":"true",
[junit4] 2> "numShards":"1",
[junit4] 2> "maxShardsPerNode":"3",
[junit4] 2> "createNodeSet":"127.0.0.1:38213_solr",
[junit4] 2> "nrtReplicas":"3",
[junit4] 2> "stateFormat":"2",
[junit4] 2> "replicationFactor":"3",
[junit4] 2> "operation":"create"} current state version: 0
[junit4] 2> 94720 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.ClusterStateMutator building a new cName: AutoscalingHistoryHandlerTest_collection
[junit4] 2> 94945 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/AutoscalingHistoryHandlerTest_collection/state.json
[junit4] 2> 95046 WARN (OverseerThreadFactory-1027-thread-2-processing-n:127.0.0.1:38239_solr) [n:127.0.0.1:38239_solr ] o.a.s.c.a.c.CreateCollectionCmd Specified number of replicas of 3 on collection AutoscalingHistoryHandlerTest_collection is higher than the number of Solr instances currently live or live and part of your createNodeSet(1). It's unusual to run two replica of the same slice on the same Solr-instance.
[junit4] 2> 95051 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 95051 INFO (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 95052 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{}}
[junit4] 2> 95052 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node2":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "base_url":"http://127.0.0.1:38213/solr"}}}
[junit4] 2> 95054 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n3",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 95054 INFO (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n3",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 95057 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node2":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "base_url":"http://127.0.0.1:38213/solr"}}}
[junit4] 2> 95057 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node2":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "base_url":"http://127.0.0.1:38213/solr"},
[junit4] 2> "core_node4":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n3",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "base_url":"http://127.0.0.1:38213/solr"}}}
[junit4] 2> 95060 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.Overseer processMessage: queueSize: 3, message = {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n5",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 95060 INFO (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n5",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 95065 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node2":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "base_url":"http://127.0.0.1:38213/solr"},
[junit4] 2> "core_node4":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n3",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "base_url":"http://127.0.0.1:38213/solr"}}}
[junit4] 2> 95065 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node2":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "base_url":"http://127.0.0.1:38213/solr"},
[junit4] 2> "core_node4":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n3",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "base_url":"http://127.0.0.1:38213/solr"},
[junit4] 2> "core_node6":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n5",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "base_url":"http://127.0.0.1:38213/solr"}}}
[junit4] 2> 95166 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/AutoscalingHistoryHandlerTest_collection/state.json version: 0
[junit4] 2> 95264 INFO (qtp529516315-1438) [n:127.0.0.1:38213_solr x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node2&collection.configName=AutoscalingHistoryHandlerTest_collection.AUTOCREATED&newCollection=true&name=AutoscalingHistoryHandlerTest_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=AutoscalingHistoryHandlerTest_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 95265 INFO (qtp529516315-1439) [n:127.0.0.1:38213_solr x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n3 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node4&collection.configName=AutoscalingHistoryHandlerTest_collection.AUTOCREATED&newCollection=true&name=AutoscalingHistoryHandlerTest_collection_shard1_replica_n3&action=CREATE&numShards=1&collection=AutoscalingHistoryHandlerTest_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 95265 INFO (qtp529516315-1441) [n:127.0.0.1:38213_solr x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n5 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node6&collection.configName=AutoscalingHistoryHandlerTest_collection.AUTOCREATED&newCollection=true&name=AutoscalingHistoryHandlerTest_collection_shard1_replica_n5&action=CREATE&numShards=1&collection=AutoscalingHistoryHandlerTest_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 95271 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n3",
[junit4] 2> "core_node_name":"core_node4",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 95271 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n3",
[junit4] 2> "core_node_name":"core_node4",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"}
[junit4] 2> 95271 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node4:{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n3",
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "base_url":"http://127.0.0.1:38213/solr"}
[junit4] 2> 95271 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(AutoscalingHistoryHandlerTest_collection//collections/AutoscalingHistoryHandlerTest_collection/state.json/1 )={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"3",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"3",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"3",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node2":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "base_url":"http://127.0.0.1:38213/solr"},
[junit4] 2> "core_node4":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n3",
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "base_url":"http://127.0.0.1:38213/solr"},
[junit4] 2> "core_node6":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n5",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "base_url":"http://127.0.0.1:38213/solr"}}}}}
[junit4] 2> 95271 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n5",
[junit4] 2> "core_node_name":"core_node6",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 95271 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n5",
[junit4] 2> "core_node_name":"core_node6",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"}
[junit4] 2> 95271 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node6:{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n5",
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "base_url":"http://127.0.0.1:38213/solr"}
[junit4] 2> 95271 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(AutoscalingHistoryHandlerTest_collection//collections/AutoscalingHistoryHandlerTest_collection/state.json/1 )={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"3",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"3",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"3",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node2":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "base_url":"http://127.0.0.1:38213/solr"},
[junit4] 2> "core_node4":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n3",
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "base_url":"http://127.0.0.1:38213/solr"},
[junit4] 2> "core_node6":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n5",
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "base_url":"http://127.0.0.1:38213/solr"}}}}}
[junit4] 2> 95278 INFO (qtp529516315-1441) [n:127.0.0.1:38213_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node6 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n5 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.8.1
[junit4] 2> 95287 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.Overseer processMessage: queueSize: 3, message = {
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node2",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 95287 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node2",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"}
[junit4] 2> 95287 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node2:{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "base_url":"http://127.0.0.1:38213/solr"}
[junit4] 2> 95287 DEBUG (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(AutoscalingHistoryHandlerTest_collection//collections/AutoscalingHistoryHandlerTest_collection/state.json/1 )={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"3",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"3",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"3",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node2":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "base_url":"http://127.0.0.1:38213/solr"},
[junit4] 2> "core_node4":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n3",
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "base_url":"http://127.0.0.1:38213/solr"},
[junit4] 2> "core_node6":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n5",
[junit4] 2> "node_name":"127.0.0.1:38213_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "base_url":"http://127.0.0.1:38213/solr"}}}}}
[junit4] 2> 95290 INFO (qtp529516315-1439) [n:127.0.0.1:38213_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node4 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n3 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.8.1
[junit4] 2> 95299 INFO (qtp529516315-1438) [n:127.0.0.1:38213_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node2 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.8.1
[junit4] 2> 95315 INFO (qtp529516315-1439) [n:127.0.0.1:38213_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node4 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n3 ] o.a.s.s.IndexSchema Schema name=default-config
[junit4] 2> 95327 INFO (qtp529516315-1441) [n:127.0.0.1:38213_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node6 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n5 ] o.a.s.s.IndexSchema Schema name=default-config
[junit4] 2> 95338 INFO (qtp529516315-1438) [n:127.0.0.
[...truncated too long message...]
[java/:?]
[junit4] 2> at org.apache.solr.cloud.autoscaling.ComputePlanAction.process(ComputePlanAction.java:116) ~[java/:?]
[junit4] 2> at org.apache.solr.cloud.autoscaling.ScheduledTriggers.lambda$null$3(ScheduledTriggers.java:331) ~[java/:?]
[junit4] 2> ... 6 more
[junit4] 2> 159563 DEBUG (AutoscalingActionExecutor-1026-thread-1) [ ] o.a.s.c.a.ScheduledTriggers Resuming trigger: AutoscalingHistoryHandlerTest_node_added_trigger after 5000ms
[junit4] 2> 159563 DEBUG (AutoscalingActionExecutor-1026-thread-1) [ ] o.a.s.c.a.ScheduledTriggers Resuming trigger: AutoscalingHistoryHandlerTest_node_lost_trigger after 5000ms
[junit4] 2> 159563 DEBUG (AutoscalingActionExecutor-1026-thread-1) [ ] o.a.s.c.a.ScheduledTriggers Resuming trigger: .auto_add_replicas after 5000ms
[junit4] 2> 159563 DEBUG (AutoscalingActionExecutor-1026-thread-1) [ ] o.a.s.c.a.ScheduledTriggers Resuming trigger: .scheduled_maintenance after 5000ms
[junit4] 2> 159563 DEBUG (AutoscalingActionExecutor-1026-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -- processing took 72 ms for event id=32cb8b0713f85eT1wno3wf8v454aqqugic3f8cug
[junit4] 2> 159563 INFO (jetty-closer-1099-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 159563 INFO (jetty-closer-1099-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6f2f380c: rootName = solr_38213, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@35f5bc01
[junit4] 2> 159563 INFO (jetty-closer-1099-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 159563 INFO (jetty-closer-1099-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster tag=null
[junit4] 2> 159563 INFO (jetty-closer-1099-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6345bb6f: rootName = solr_38239, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@35f5bc01
[junit4] 2> 159564 INFO (jetty-closer-1099-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster tag=null
[junit4] 2> 159564 INFO (closeThreadPool-1116-thread-2) [ ] o.a.s.c.Overseer Overseer (id=72994593561247750-127.0.0.1:38239_solr-n_0000000000) closing
[junit4] 2> 159567 INFO (OverseerStateUpdate-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [n:127.0.0.1:38239_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:38239_solr
[junit4] 2> 159567 INFO (OverseerAutoScalingTriggerThread-72994593561247750-127.0.0.1:38239_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 159567 DEBUG (closeThreadPool-1116-thread-2) [ ] o.a.s.c.a.ScheduledTriggers Shutting down scheduled thread pool executor now
[junit4] 2> 159568 DEBUG (closeThreadPool-1116-thread-2) [ ] o.a.s.c.a.ScheduledTriggers Shutting down action executor now
[junit4] 2> 159568 DEBUG (closeThreadPool-1116-thread-2) [ ] o.a.s.c.a.ScheduledTriggers Awaiting termination for action executor
[junit4] 2> 159568 DEBUG (closeThreadPool-1116-thread-2) [ ] o.a.s.c.a.ScheduledTriggers Awaiting termination for scheduled thread pool executor
[junit4] 2> 159568 DEBUG (closeThreadPool-1116-thread-2) [ ] o.a.s.c.a.ScheduledTriggers ScheduledTriggers closed completely
[junit4] 2> 159568 DEBUG (closeThreadPool-1116-thread-2) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
[junit4] 2> 159572 INFO (closeThreadPool-1116-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72994593561247750-127.0.0.1:38239_solr-n_0000000000) closing
[junit4] 2> 159574 WARN (jetty-launcher-992-thread-2-SendThread(127.0.0.1:36151)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x103543233be0006.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x103543233be0006, 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 0x103543233be0006, 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> 159574 INFO (zkCallback-1032-thread-4) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 159650 INFO (jetty-closer-1099-thread-3) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@2e98dc0b{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 159650 INFO (jetty-closer-1099-thread-3) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@4891eca7{/solr,null,STOPPED}
[junit4] 2> 159650 INFO (jetty-closer-1099-thread-3) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 159750 INFO (jetty-closer-1099-thread-2) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@11482a9a{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 159751 INFO (jetty-closer-1099-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@49be3adb{/solr,null,STOPPED}
[junit4] 2> 159751 INFO (jetty-closer-1099-thread-2) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 159849 INFO (jetty-closer-1099-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72994593561247750-127.0.0.1:38239_solr-n_0000000000) closing
[junit4] 2> 159850 INFO (jetty-closer-1099-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@2af85163{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 159851 INFO (jetty-closer-1099-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@3b7efa08{/solr,null,STOPPED}
[junit4] 2> 159851 INFO (jetty-closer-1099-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 159852 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[DA322DB11A8FDEC3]-worker) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 160055 WARN (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 5 /solr/clusterprops.json
[junit4] 2> 5 /solr/aliases.json
[junit4] 2> 4 /solr/collections/AutoscalingHistoryHandlerTest_collection/terms/shard1
[junit4] 2> 3 /solr/packages.json
[junit4] 2> 3 /solr/security.json
[junit4] 2> 3 /solr/collections/.system/terms/shard1
[junit4] 2> 3 /solr/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/managed-schema
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 17 /solr/collections/AutoscalingHistoryHandlerTest_collection/state.json
[junit4] 2> 14 /solr/collections/.system/state.json
[junit4] 2> 12 /solr/autoscaling.json
[junit4] 2> 5 /solr/clusterstate.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 36 /solr/overseer/queue
[junit4] 2> 17 /solr/live_nodes
[junit4] 2> 11 /solr/collections
[junit4] 2> 9 /solr/collections/AutoscalingHistoryHandlerTest_collection/state.json
[junit4] 2> 8 /solr/overseer/collection-queue-work
[junit4] 2> 6 /solr/collections/.system/state.json
[junit4] 2>
[junit4] 2> 160058 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[DA322DB11A8FDEC3]-worker) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:36151
[junit4] 2> 160058 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[DA322DB11A8FDEC3]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:36151
[junit4] 2> 160058 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[DA322DB11A8FDEC3]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 36151
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.8/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_DA322DB11A8FDEC3-001
[junit4] 2> Feb 13, 2021 9:24:58 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=FastDecompressionCompressingStoredFieldsData(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST_DECOMPRESSION, chunkSize=54, maxDocsPerChunk=649, blockShift=8), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST_DECOMPRESSION, chunkSize=54, blockSize=8)), sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=ja-JP, timezone=Indian/Comoro
[junit4] 2> NOTE: Linux 4.15.0-112-generic amd64/Oracle Corporation 1.8.0_281 (64-bit)/cpus=4,threads=1,free=102771136,total=346554368
[junit4] 2> NOTE: All tests run in this JVM: [TestSafeXMLParsing, TestDownShardTolerantSearch, SplitHandlerTest, TestStressVersions, TestCoreDiscovery, JWTAuthPluginIntegrationTest, TestRestoreCore, HdfsRecoveryZkTest, AutoscalingHistoryHandlerTest]
[junit4] Completed [46/923 (1!)] on J2 in 70.02s, 1 test, 1 failure <<< FAILURES!
[...truncated 53748 lines...]