You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2021/08/10 11:04:56 UTC
[JENKINS] Lucene » Lucene-Solr-BadApples-Tests-8.x - Build # 365 - Unstable!
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-BadApples-Tests-8.x/365/
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([F02ADEA496F1703E:9DD67A592CB98F39]: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:285)
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 13707 lines...]
[junit4] Suite: org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest
[junit4] 2> 268606 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-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-BadApples-Tests-8.x/solr/server/solr/configsets/_default/conf'
[junit4] 2> 268607 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_F02ADEA496F1703E-001/data-dir-34-001
[junit4] 2> 268607 WARN (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=28 numCloses=28
[junit4] 2> 268607 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 268609 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 268610 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 268610 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_F02ADEA496F1703E-001/tempDir-001
[junit4] 2> 268610 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 268611 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 268611 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 268612 WARN (ZkTestServer Run Thread) [ ] o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
[junit4] 2> 268711 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port: 46151
[junit4] 2> 268711 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-worker) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:46151
[junit4] 2> 268711 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:46151
[junit4] 2> 268711 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 46151
[junit4] 2> 268713 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 268718 INFO (zkConnectionManagerCallback-4289-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 268718 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 268730 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 268734 INFO (zkConnectionManagerCallback-4291-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 268734 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 268735 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 268742 INFO (zkConnectionManagerCallback-4293-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 268742 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 268744 WARN (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-worker-SendThread(127.0.0.1:46151)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x106e675f5bc0002.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x106e675f5bc0002, 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 0x106e675f5bc0002, 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> 268847 INFO (jetty-launcher-4294-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 268847 INFO (jetty-launcher-4294-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 268847 INFO (jetty-launcher-4294-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 268847 INFO (jetty-launcher-4294-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 268847 INFO (jetty-launcher-4294-thread-2) [ ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
[junit4] 2> 268847 INFO (jetty-launcher-4294-thread-1) [ ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
[junit4] 2> 268850 INFO (jetty-launcher-4294-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 268851 INFO (jetty-launcher-4294-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 268851 INFO (jetty-launcher-4294-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 268851 INFO (jetty-launcher-4294-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 268851 INFO (jetty-launcher-4294-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 268851 INFO (jetty-launcher-4294-thread-2) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 268851 INFO (jetty-launcher-4294-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@58fdde99{/solr,null,AVAILABLE}
[junit4] 2> 268851 INFO (jetty-launcher-4294-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@31b8b79e{/solr,null,AVAILABLE}
[junit4] 2> 268852 INFO (jetty-launcher-4294-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@6672b7ef{SSL, (ssl, http/1.1)}{127.0.0.1:45409}
[junit4] 2> 268852 INFO (jetty-launcher-4294-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@57f08d40{SSL, (ssl, http/1.1)}{127.0.0.1:43401}
[junit4] 2> 268852 INFO (jetty-launcher-4294-thread-2) [ ] o.e.j.s.Server Started @268897ms
[junit4] 2> 268852 INFO (jetty-launcher-4294-thread-1) [ ] o.e.j.s.Server Started @268897ms
[junit4] 2> 268852 INFO (jetty-launcher-4294-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, zkHost=127.0.0.1:46151/solr, hostPort=45409}
[junit4] 2> 268852 INFO (jetty-launcher-4294-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, zkHost=127.0.0.1:46151/solr, hostPort=43401}
[junit4] 2> 268852 ERROR (jetty-launcher-4294-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 268852 ERROR (jetty-launcher-4294-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 268852 INFO (jetty-launcher-4294-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 268852 INFO (jetty-launcher-4294-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 268852 INFO (jetty-launcher-4294-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.10.0
[junit4] 2> 268852 INFO (jetty-launcher-4294-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.10.0
[junit4] 2> 268852 INFO (jetty-launcher-4294-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 268852 INFO (jetty-launcher-4294-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 268852 INFO (jetty-launcher-4294-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr
[junit4] 2> 268852 INFO (jetty-launcher-4294-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr
[junit4] 2> 268853 INFO (jetty-launcher-4294-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-08-10T10:08:20.849Z
[junit4] 2> 268853 INFO (jetty-launcher-4294-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-08-10T10:08:20.849Z
[junit4] 2> 268854 INFO (jetty-launcher-4294-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 268855 INFO (jetty-launcher-4294-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 268855 INFO (zkConnectionManagerCallback-4298-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 268855 INFO (jetty-launcher-4294-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 268855 INFO (zkConnectionManagerCallback-4297-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 268855 INFO (jetty-launcher-4294-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 268856 INFO (jetty-launcher-4294-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 268856 INFO (jetty-launcher-4294-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 268861 WARN (jetty-launcher-4294-thread-1-SendThread(127.0.0.1:46151)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x106e675f5bc0003.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x106e675f5bc0003, 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 0x106e675f5bc0003, 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> 269319 INFO (jetty-launcher-4294-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 269320 WARN (jetty-launcher-4294-thread-1) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 269321 WARN (jetty-launcher-4294-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@47d29be7[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 269321 WARN (jetty-launcher-4294-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@47d29be7[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 269324 WARN (jetty-launcher-4294-thread-1) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 269327 WARN (jetty-launcher-4294-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@7fb627e2[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 269327 WARN (jetty-launcher-4294-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@7fb627e2[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 269328 INFO (jetty-launcher-4294-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46151/solr
[junit4] 2> 269334 INFO (jetty-launcher-4294-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 269334 INFO (zkConnectionManagerCallback-4312-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 269334 INFO (jetty-launcher-4294-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 269436 INFO (jetty-launcher-4294-thread-1) [n:127.0.0.1:43401_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 269438 INFO (zkConnectionManagerCallback-4314-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 269438 INFO (jetty-launcher-4294-thread-1) [n:127.0.0.1:43401_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 269506 WARN (jetty-launcher-4294-thread-1) [n:127.0.0.1:43401_solr ] o.a.s.c.ZkController Contents of zookeeper /security.json are world-readable; consider setting up ACLs as described in https://solr.apache.org/guide/zookeeper-access-control.html
[junit4] 2> 269511 INFO (jetty-launcher-4294-thread-1) [n:127.0.0.1:43401_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:43401_solr
[junit4] 2> 269512 INFO (jetty-launcher-4294-thread-1) [n:127.0.0.1:43401_solr ] o.a.s.c.Overseer Overseer (id=73999838206492678-127.0.0.1:43401_solr-n_0000000000) starting
[junit4] 2> 269517 INFO (jetty-launcher-4294-thread-1) [n:127.0.0.1:43401_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:43401_solr
[junit4] 2> 269517 INFO (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:43401_solr
[junit4] 2> 269517 DEBUG (OverseerAutoScalingTriggerThread-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and .scheduled_maintenance triggers
[junit4] 2> 269518 INFO (jetty-launcher-4294-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 269518 WARN (jetty-launcher-4294-thread-2) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 269519 DEBUG (OverseerAutoScalingTriggerThread-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1
[junit4] 2> 269520 DEBUG (OverseerAutoScalingTriggerThread-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 0
[junit4] 2> 269520 DEBUG (OverseerAutoScalingTriggerThread-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
[junit4] 2> 269520 INFO (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 269520 WARN (jetty-launcher-4294-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@57e676ca[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 269520 WARN (jetty-launcher-4294-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@57e676ca[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 269523 WARN (jetty-launcher-4294-thread-2) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 269524 INFO (jetty-launcher-4294-thread-1) [n:127.0.0.1:43401_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 269524 WARN (jetty-launcher-4294-thread-1) [n:127.0.0.1:43401_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> 269530 WARN (jetty-launcher-4294-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@5ae580de[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 269530 WARN (jetty-launcher-4294-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@5ae580de[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 269531 INFO (jetty-launcher-4294-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46151/solr
[junit4] 2> 269532 DEBUG (OverseerAutoScalingTriggerThread-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial livenodes: [127.0.0.1:43401_solr]
[junit4] 2> 269532 INFO (jetty-launcher-4294-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 269533 DEBUG (OverseerAutoScalingTriggerThread-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded markers
[junit4] 2> 269533 INFO (zkConnectionManagerCallback-4329-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 269533 INFO (jetty-launcher-4294-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 269533 DEBUG (OverseerAutoScalingTriggerThread-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
[junit4] 2> 269534 DEBUG (ScheduledTrigger-4319-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 and last live nodes: 1
[junit4] 2> 269539 WARN (jetty-launcher-4294-thread-2-SendThread(127.0.0.1:46151)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x106e675f5bc0007.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x106e675f5bc0007, 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 0x106e675f5bc0007, 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> 269563 INFO (jetty-launcher-4294-thread-1) [n:127.0.0.1:43401_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 269598 INFO (jetty-launcher-4294-thread-1) [n:127.0.0.1:43401_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43401.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@65d424f
[junit4] 2> 269605 INFO (jetty-launcher-4294-thread-1) [n:127.0.0.1:43401_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43401.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@65d424f
[junit4] 2> 269606 INFO (jetty-launcher-4294-thread-1) [n:127.0.0.1:43401_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43401.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@65d424f
[junit4] 2> 269607 INFO (jetty-launcher-4294-thread-1) [n:127.0.0.1:43401_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_F02ADEA496F1703E-001/tempDir-001/node1
[junit4] 2> 269643 INFO (jetty-launcher-4294-thread-2) [n:127.0.0.1:45409_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 269643 INFO (zkConnectionManagerCallback-4336-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 269643 INFO (jetty-launcher-4294-thread-2) [n:127.0.0.1:45409_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 269647 WARN (jetty-launcher-4294-thread-2) [n:127.0.0.1:45409_solr ] o.a.s.c.ZkController Contents of zookeeper /security.json are world-readable; consider setting up ACLs as described in https://solr.apache.org/guide/zookeeper-access-control.html
[junit4] 2> 269648 INFO (jetty-launcher-4294-thread-2) [n:127.0.0.1:45409_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 269651 INFO (jetty-launcher-4294-thread-2) [n:127.0.0.1:45409_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:45409_solr as DOWN
[junit4] 2> 269652 INFO (jetty-launcher-4294-thread-2) [n:127.0.0.1:45409_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 2147483647 cores with initial capacity of 1024
[junit4] 2> 269652 INFO (jetty-launcher-4294-thread-2) [n:127.0.0.1:45409_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:45409_solr
[junit4] 2> 269653 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "base_url":"https://127.0.0.1:45409/solr",
[junit4] 2> "operation":"downnode"} current state version: 0
[junit4] 2> 269653 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 127.0.0.1:45409_solr
[junit4] 2> 269654 INFO (zkCallback-4313-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 269654 INFO (zkCallback-4335-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 269656 INFO (jetty-launcher-4294-thread-2) [n:127.0.0.1:45409_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 269656 WARN (jetty-launcher-4294-thread-2) [n:127.0.0.1:45409_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> 269684 INFO (jetty-launcher-4294-thread-2) [n:127.0.0.1:45409_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 269708 INFO (jetty-launcher-4294-thread-2) [n:127.0.0.1:45409_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45409.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@65d424f
[junit4] 2> 269731 INFO (jetty-launcher-4294-thread-2) [n:127.0.0.1:45409_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45409.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@65d424f
[junit4] 2> 269731 INFO (jetty-launcher-4294-thread-2) [n:127.0.0.1:45409_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45409.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@65d424f
[junit4] 2> 269732 INFO (jetty-launcher-4294-thread-2) [n:127.0.0.1:45409_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_F02ADEA496F1703E-001/tempDir-001/node2
[junit4] 2> 269750 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-worker) [ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2
[junit4] 2> 269751 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 269753 INFO (zkConnectionManagerCallback-4349-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 269753 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 269757 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 269758 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:46151/solr ready
[junit4] 2> 269803 INFO (OverseerThreadFactory-4324-thread-1-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection .system
[junit4] 2> 269806 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_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:43401_solr",
[junit4] 2> "nrtReplicas":"1",
[junit4] 2> "stateFormat":"2",
[junit4] 2> "replicationFactor":"1",
[junit4] 2> "operation":"create"} current state version: 0
[junit4] 2> 269806 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.o.ClusterStateMutator building a new cName: .system
[junit4] 2> 269807 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/.system/state.json
[junit4] 2> 269911 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:43401_solr",
[junit4] 2> "base_url":"https://127.0.0.1:43401/solr",
[junit4] 2> "collection":".system",
[junit4] 2> "shard":"shard1",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 269911 INFO (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:43401_solr",
[junit4] 2> "base_url":"https://127.0.0.1:43401/solr",
[junit4] 2> "collection":".system",
[junit4] 2> "shard":"shard1",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 269912 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{}}
[junit4] 2> 269913 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_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:43401_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "base_url":"https://127.0.0.1:43401/solr"}}}
[junit4] 2> 270013 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 0
[junit4] 2> 270145 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_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> 270146 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_solr x:.system_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 2147483647 cores with initial capacity of 1024
[junit4] 2> 270152 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_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:43401_solr",
[junit4] 2> "base_url":"https://127.0.0.1:43401/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> 270152 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_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:43401_solr",
[junit4] 2> "base_url":"https://127.0.0.1:43401/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> 270152 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_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:43401_solr",
[junit4] 2> "base_url":"https://127.0.0.1:43401/solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}
[junit4] 2> 270152 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_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:43401_solr",
[junit4] 2> "base_url":"https://127.0.0.1:43401/solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}}}}}
[junit4] 2> 270160 WARN (qtp1560864304-6694) [n:127.0.0.1:43401_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> 270160 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.10.0
[junit4] 2> 270161 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_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> 270162 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_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> 270163 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_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> 270165 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_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> 270167 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_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> 270167 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_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> 270168 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43401.solr.core..system.shard1.replica_n1' (registry 'solr.core..system.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@65d424f
[junit4] 2> 270168 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_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-BadApples-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_F02ADEA496F1703E-001/tempDir-001/node1/.system_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_F02ADEA496F1703E-001/tempDir-001/node1/.system_shard1_replica_n1/data/]
[junit4] 2> 270224 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_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> 270224 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_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> 270226 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_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> 270226 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 270228 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_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> 270229 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_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> 270229 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_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> 270229 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_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> 270230 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_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> 270230 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_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 1707700495031730176
[junit4] 2> 270233 INFO (searcherExecutor-4351-thread-1-processing-n:127.0.0.1:43401_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node2) [n:127.0.0.1:43401_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> 270236 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_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> 270237 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_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> 270240 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_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> 270241 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_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> 270241 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:43401/solr/.system_shard1_replica_n1/
[junit4] 2> 270241 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_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> 270242 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SyncStrategy https://127.0.0.1:43401/solr/.system_shard1_replica_n1/ has no replicas
[junit4] 2> 270242 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_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/73999838206492678-core_node2-n_0000000000
[junit4] 2> 270245 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:43401/solr/.system_shard1_replica_n1/ shard1
[junit4] 2> 270245 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:43401_solr",
[junit4] 2> "base_url":"https://127.0.0.1:43401/solr",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":".system",
[junit4] 2> "state":"active",
[junit4] 2> "operation":"leader"} current state version: 0
[junit4] 2> 270346 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 1
[junit4] 2> 270347 INFO (zkCallback-4313-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> 270347 INFO (zkCallback-4313-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> 270347 INFO (zkCallback-4313-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> 270349 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_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> 270351 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_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:43401_solr",
[junit4] 2> "base_url":"https://127.0.0.1:43401/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> 270352 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_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:43401_solr",
[junit4] 2> "base_url":"https://127.0.0.1:43401/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> 270352 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_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:43401_solr",
[junit4] 2> "base_url":"https://127.0.0.1:43401/solr",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "leader":"true"}
[junit4] 2> 270352 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(.system//collections/.system/state.json/2 )={
[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:43401_solr",
[junit4] 2> "base_url":"https://127.0.0.1:43401/solr",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "leader":"true"}}}}}
[junit4] 2> 270354 INFO (qtp1560864304-6694) [n:127.0.0.1:43401_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=208
[junit4] 2> 270356 INFO (qtp1821039775-6695) [n:127.0.0.1:45409_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> 270452 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 2
[junit4] 2> 270453 INFO (zkCallback-4313-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> 270453 INFO (zkCallback-4335-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> 270453 INFO (zkCallback-4313-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> 270453 INFO (zkCallback-4313-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> 270453 INFO (zkCallback-4313-thread-4) [ ] 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> 270454 INFO (qtp1821039775-6695) [n:127.0.0.1:45409_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:43401_solr&wt=javabin&version=2} status=0 QTime=659
[junit4] 2> 270454 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-worker) [ ] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection: .system
[junit4] 2> 270462 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection AutoscalingHistoryHandlerTest_collection
[junit4] 2> 270463 INFO (OverseerCollectionConfigSetProcessor-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_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> 270463 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED
[junit4] 2> 270464 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/protwords.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/protwords.txt
[junit4] 2> 270465 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/managed-schema to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/managed-schema
[junit4] 2> 270467 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/solrconfig.xml to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/solrconfig.xml
[junit4] 2> 270469 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270470 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270472 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270473 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270475 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270481 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270482 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270484 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270485 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270487 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270493 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270495 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270499 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270502 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270510 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270512 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270513 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270515 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270516 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270518 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270519 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270522 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270524 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270526 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270528 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270530 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270532 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270534 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270535 DEBUG (ScheduledTrigger-4319-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 1
[junit4] 2> 270537 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270539 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270541 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270543 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270545 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270547 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270549 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270555 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270559 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270568 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270570 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270572 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/synonyms.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/synonyms.txt
[junit4] 2> 270573 INFO (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/stopwords.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/stopwords.txt
[junit4] 2> 270579 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_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:45409_solr",
[junit4] 2> "nrtReplicas":"3",
[junit4] 2> "stateFormat":"2",
[junit4] 2> "replicationFactor":"3",
[junit4] 2> "operation":"create"} current state version: 0
[junit4] 2> 270579 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.o.ClusterStateMutator building a new cName: AutoscalingHistoryHandlerTest_collection
[junit4] 2> 270679 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/AutoscalingHistoryHandlerTest_collection/state.json
[junit4] 2> 270782 WARN (OverseerThreadFactory-4324-thread-2-processing-n:127.0.0.1:43401_solr) [n:127.0.0.1:43401_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> 270786 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "base_url":"https://127.0.0.1:45409/solr",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 270786 INFO (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "base_url":"https://127.0.0.1:45409/solr",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 270787 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{}}
[junit4] 2> 270787 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node3":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "base_url":"https://127.0.0.1:45409/solr"}}}
[junit4] 2> 270788 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "base_url":"https://127.0.0.1:45409/solr",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 270788 INFO (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "base_url":"https://127.0.0.1:45409/solr",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 270789 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node3":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "base_url":"https://127.0.0.1:45409/solr"}}}
[junit4] 2> 270789 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_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_node3":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "base_url":"https://127.0.0.1:45409/solr"},
[junit4] 2> "core_node5":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "base_url":"https://127.0.0.1:45409/solr"}}}
[junit4] 2> 270790 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.Overseer processMessage: queueSize: 3, message = {
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "base_url":"https://127.0.0.1:45409/solr",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 270790 INFO (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "base_url":"https://127.0.0.1:45409/solr",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 270791 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_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_node3":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "base_url":"https://127.0.0.1:45409/solr"},
[junit4] 2> "core_node5":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "base_url":"https://127.0.0.1:45409/solr"}}}
[junit4] 2> 270791 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_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_node3":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "base_url":"https://127.0.0.1:45409/solr"},
[junit4] 2> "core_node5":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "base_url":"https://127.0.0.1:45409/solr"},
[junit4] 2> "core_node6":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "base_url":"https://127.0.0.1:45409/solr"}}}
[junit4] 2> 270892 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/AutoscalingHistoryHandlerTest_collection/state.json version: 0
[junit4] 2> 271003 INFO (qtp1821039775-6693) [n:127.0.0.1:45409_solr x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&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> 271005 INFO (qtp1821039775-6695) [n:127.0.0.1:45409_solr x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n2 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node5&collection.configName=AutoscalingHistoryHandlerTest_collection.AUTOCREATED&newCollection=true&name=AutoscalingHistoryHandlerTest_collection_shard1_replica_n2&action=CREATE&numShards=1&collection=AutoscalingHistoryHandlerTest_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 271008 INFO (qtp1821039775-6690) [n:127.0.0.1:45409_solr x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n4 ] 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_n4&action=CREATE&numShards=1&collection=AutoscalingHistoryHandlerTest_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 271014 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "core_node_name":"core_node5",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "base_url":"https://127.0.0.1:45409/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> 271014 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "core_node_name":"core_node5",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "base_url":"https://127.0.0.1:45409/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> 271014 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node5:{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "base_url":"https://127.0.0.1:45409/solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}
[junit4] 2> 271014 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_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_node3":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "base_url":"https://127.0.0.1:45409/solr"},
[junit4] 2> "core_node5":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "base_url":"https://127.0.0.1:45409/solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"},
[junit4] 2> "core_node6":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "base_url":"https://127.0.0.1:45409/solr"}}}}}
[junit4] 2> 271014 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node3",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "base_url":"https://127.0.0.1:45409/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> 271015 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_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_node3",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "base_url":"https://127.0.0.1:45409/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> 271015 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node3:{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "base_url":"https://127.0.0.1:45409/solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}
[junit4] 2> 271015 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_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_node3":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "base_url":"https://127.0.0.1:45409/solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"},
[junit4] 2> "core_node5":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "base_url":"https://127.0.0.1:45409/solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"},
[junit4] 2> "core_node6":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "base_url":"https://127.0.0.1:45409/solr"}}}}}
[junit4] 2> 271022 DEBUG (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.Overseer processMessage: queueSize: 3, message = {
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
[junit4] 2> "core_node_name":"core_node6",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:45409_solr",
[junit4] 2> "base_url":"https://127.0.0.1:45409/solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2>
[...truncated too long message...]
ception: Unable to read additional data from server sessionid 0x106e675f5bc0008, 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> 334394 INFO (jetty-closer-4401-thread-3) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@42b71abb{SSL, (ssl, http/1.1)}{127.0.0.1:0}
[junit4] 2> 334394 INFO (jetty-closer-4401-thread-3) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@41a1631{/solr,null,STOPPED}
[junit4] 2> 334395 INFO (jetty-closer-4401-thread-3) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 334481 INFO (zkCallback-4313-thread-10) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 334482 INFO (jetty-closer-4401-thread-2) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@6672b7ef{SSL, (ssl, http/1.1)}{127.0.0.1:0}
[junit4] 2> 334482 INFO (jetty-closer-4401-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@31b8b79e{/solr,null,STOPPED}
[junit4] 2> 334482 INFO (jetty-closer-4401-thread-2) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 334493 INFO (jetty-closer-4401-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
[junit4] 2> 334493 INFO (jetty-closer-4401-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@116fbc25: rootName = solr_43401, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@78931da6
[junit4] 2> 334499 INFO (jetty-closer-4401-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
[junit4] 2> 334499 INFO (jetty-closer-4401-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@73994ff3: rootName = solr_43401, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@4a4f19e0
[junit4] 2> 334502 INFO (jetty-closer-4401-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 334502 INFO (jetty-closer-4401-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5fa8c8d7: rootName = solr_43401, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@324c4851
[junit4] 2> 334502 INFO (jetty-closer-4401-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster tag=null
[junit4] 2> 334509 INFO (closeThreadPool-4418-thread-1) [ ] o.a.s.c.Overseer Overseer (id=73999838206492678-127.0.0.1:43401_solr-n_0000000000) closing
[junit4] 2> 334509 INFO (OverseerStateUpdate-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [n:127.0.0.1:43401_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:43401_solr
[junit4] 2> 334516 DEBUG (closeThreadPool-4418-thread-1) [ ] o.a.s.c.a.ScheduledTriggers Shutting down scheduled thread pool executor now
[junit4] 2> 334517 DEBUG (closeThreadPool-4418-thread-1) [ ] o.a.s.c.a.ScheduledTriggers Shutting down action executor now
[junit4] 2> 334517 DEBUG (closeThreadPool-4418-thread-1) [ ] o.a.s.c.a.ScheduledTriggers Awaiting termination for action executor
[junit4] 2> 334517 INFO (OverseerAutoScalingTriggerThread-73999838206492678-127.0.0.1:43401_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 334518 DEBUG (closeThreadPool-4418-thread-1) [ ] o.a.s.c.a.ScheduledTriggers Awaiting termination for scheduled thread pool executor
[junit4] 2> 334518 DEBUG (closeThreadPool-4418-thread-1) [ ] o.a.s.c.a.ScheduledTriggers ScheduledTriggers closed completely
[junit4] 2> 334518 DEBUG (closeThreadPool-4418-thread-1) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
[junit4] 2> 334518 INFO (closeThreadPool-4418-thread-2) [ ] o.a.s.c.Overseer Overseer (id=73999838206492678-127.0.0.1:43401_solr-n_0000000000) closing
[junit4] 2> 334518 WARN (jetty-launcher-4294-thread-1-SendThread(127.0.0.1:46151)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x106e675f5bc0006.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x106e675f5bc0006, 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 0x106e675f5bc0006, 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> 334618 INFO (jetty-closer-4401-thread-1) [ ] o.a.s.c.Overseer Overseer (id=73999838206492678-127.0.0.1:43401_solr-n_0000000000) closing
[junit4] 2> 334620 INFO (jetty-closer-4401-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@57f08d40{SSL, (ssl, http/1.1)}{127.0.0.1:0}
[junit4] 2> 334620 INFO (jetty-closer-4401-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@58fdde99{/solr,null,STOPPED}
[junit4] 2> 334620 INFO (jetty-closer-4401-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 334621 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-worker) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 334824 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/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> 23 /solr/collections/AutoscalingHistoryHandlerTest_collection/state.json
[junit4] 2> 19 /solr/collections/.system/state.json
[junit4] 2> 12 /solr/autoscaling.json
[junit4] 2> 5 /solr/clusterstate.json
[junit4] 2> 5 /solr/clusterprops.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 34 /solr/overseer/queue
[junit4] 2> 17 /solr/live_nodes
[junit4] 2> 11 /solr/collections
[junit4] 2> 8 /solr/collections/AutoscalingHistoryHandlerTest_collection/state.json
[junit4] 2> 8 /solr/overseer/collection-queue-work
[junit4] 2> 7 /solr/collections/.system/state.json
[junit4] 2>
[junit4] 2> 334828 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-worker) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:46151
[junit4] 2> 334828 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:46151
[junit4] 2> 334828 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[F02ADEA496F1703E]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 46151
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_F02ADEA496F1703E-001
[junit4] 2> Aug 10, 2021 10:09:26 AM 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=27674, maxDocsPerChunk=7, blockShift=5), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST_DECOMPRESSION, chunkSize=27674, maxDocsPerChunk=7, blockSize=5)), sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=en-AU, timezone=Africa/Blantyre
[junit4] 2> NOTE: Linux 5.4.0-45-generic amd64/Oracle Corporation 1.8.0_291 (64-bit)/cpus=4,threads=1,free=240724672,total=418906112
[junit4] 2> NOTE: All tests run in this JVM: [TestStressLiveNodes, ManagedSchemaRoundRobinCloudTest, PreAnalyzedUpdateProcessorTest, TestCollectionAPIs, TestCollationFieldDocValues, TestSolrCoreSnapshots, TestFieldCache, DateRangeFieldTest, OverseerModifyCollectionTest, LeaderElectionTest, IndexSizeEstimatorTest, TestSweetSpotSimilarityFactory, SuggesterWFSTTest, TestPhraseSuggestions, BigEndianAscendingWordSerializerTest, QueryElevationComponentTest, MaxSizeAutoCommitTest, ByteBuffersDirectoryFactoryTest, TestUnifiedSolrHighlighter, TestPullReplicaWithAuth, AutoscalingHistoryHandlerTest]
[junit4] Completed [119/945 (1!)] on J2 in 67.03s, 1 test, 1 failure <<< FAILURES!
[...truncated 55418 lines...]