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/01/18 23:01:10 UTC
[JENKINS] Lucene » Lucene-Solr-Tests-8.x - Build # 1412 - Still Unstable!
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.x/1412/
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([D891DE97CCD73041:B56D7A6A769FCF46]:0)
at org.junit.Assert.fail(Assert.java:89)
at org.junit.Assert.assertTrue(Assert.java:42)
at org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest.testHistory(AutoscalingHistoryHandlerTest.java:283)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 13586 lines...]
[junit4] Suite: org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest
[junit4] 2> 132232 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/server/solr/configsets/_default/conf'
[junit4] 2> 132233 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_D891DE97CCD73041-001/data-dir-18-001
[junit4] 2> 132233 WARN (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
[junit4] 2> 132233 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 132235 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 132235 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 132235 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.c.SolrCloudTestCase Using per-replica state
[junit4] 2> 132235 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_D891DE97CCD73041-001/tempDir-001
[junit4] 2> 132236 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 132236 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 132236 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 132237 WARN (ZkTestServer Run Thread) [ ] o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
[junit4] 2> 132336 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port: 41291
[junit4] 2> 132336 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:41291
[junit4] 2> 132336 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:41291
[junit4] 2> 132336 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 41291
[junit4] 2> 132339 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 132341 INFO (zkConnectionManagerCallback-1041-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 132341 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 132345 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 132346 INFO (zkConnectionManagerCallback-1043-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 132346 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 132347 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 132347 INFO (zkConnectionManagerCallback-1045-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 132348 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 132349 WARN (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker-SendThread(127.0.0.1:41291)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x102ce73287d0002.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x102ce73287d0002, 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 0x102ce73287d0002, 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> 132457 INFO (jetty-launcher-1046-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 132457 INFO (jetty-launcher-1046-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 132457 INFO (jetty-launcher-1046-thread-1) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 132523 INFO (jetty-launcher-1046-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 132523 INFO (jetty-launcher-1046-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 132523 INFO (jetty-launcher-1046-thread-2) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 132576 INFO (jetty-launcher-1046-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 132576 INFO (jetty-launcher-1046-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 132576 INFO (jetty-launcher-1046-thread-2) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 132585 INFO (jetty-launcher-1046-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 132585 INFO (jetty-launcher-1046-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 132585 INFO (jetty-launcher-1046-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 132586 INFO (jetty-launcher-1046-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5a701d2a{/solr,null,AVAILABLE}
[junit4] 2> 132588 INFO (jetty-launcher-1046-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1851f6f9{/solr,null,AVAILABLE}
[junit4] 2> 132589 INFO (jetty-launcher-1046-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5e0cebf3{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:38791}
[junit4] 2> 132589 INFO (jetty-launcher-1046-thread-1) [ ] o.e.j.s.Server Started @132617ms
[junit4] 2> 132589 INFO (jetty-launcher-1046-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, zkHost=127.0.0.1:41291/solr, hostPort=38791}
[junit4] 2> 132589 ERROR (jetty-launcher-1046-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 132589 INFO (jetty-launcher-1046-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 132589 INFO (jetty-launcher-1046-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.9.0
[junit4] 2> 132589 INFO (jetty-launcher-1046-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 132589 INFO (jetty-launcher-1046-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
[junit4] 2> 132589 INFO (jetty-launcher-1046-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-01-18T22:05:39.101Z
[junit4] 2> 132593 INFO (jetty-launcher-1046-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 132593 INFO (jetty-launcher-1046-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@4c9a0089{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:36691}
[junit4] 2> 132593 INFO (jetty-launcher-1046-thread-2) [ ] o.e.j.s.Server Started @132622ms
[junit4] 2> 132593 INFO (jetty-launcher-1046-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, zkHost=127.0.0.1:41291/solr, hostPort=36691}
[junit4] 2> 132593 ERROR (jetty-launcher-1046-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 132593 INFO (jetty-launcher-1046-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 132593 INFO (jetty-launcher-1046-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.9.0
[junit4] 2> 132593 INFO (jetty-launcher-1046-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 132593 INFO (jetty-launcher-1046-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
[junit4] 2> 132593 INFO (jetty-launcher-1046-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2021-01-18T22:05:39.105Z
[junit4] 2> 132595 INFO (jetty-launcher-1046-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 132596 INFO (zkConnectionManagerCallback-1048-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 132596 INFO (jetty-launcher-1046-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 132597 INFO (zkConnectionManagerCallback-1050-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 132597 INFO (jetty-launcher-1046-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 132597 INFO (jetty-launcher-1046-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 132601 INFO (jetty-launcher-1046-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 132615 WARN (jetty-launcher-1046-thread-1-SendThread(127.0.0.1:41291)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x102ce73287d0003.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x102ce73287d0003, 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 0x102ce73287d0003, 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> 132717 WARN (jetty-launcher-1046-thread-2-SendThread(127.0.0.1:41291)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x102ce73287d0004.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x102ce73287d0004, 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 0x102ce73287d0004, 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> 133072 INFO (jetty-launcher-1046-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 133073 WARN (jetty-launcher-1046-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@7730867f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 133073 WARN (jetty-launcher-1046-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@7730867f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 133076 WARN (jetty-launcher-1046-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@5b621338[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 133076 WARN (jetty-launcher-1046-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@5b621338[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 133077 INFO (jetty-launcher-1046-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41291/solr
[junit4] 2> 133078 INFO (jetty-launcher-1046-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 133080 INFO (zkConnectionManagerCallback-1064-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 133080 INFO (jetty-launcher-1046-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 133182 INFO (jetty-launcher-1046-thread-1) [n:127.0.0.1:38791_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 133188 INFO (zkConnectionManagerCallback-1066-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 133188 INFO (jetty-launcher-1046-thread-1) [n:127.0.0.1:38791_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 133191 INFO (jetty-launcher-1046-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 133192 WARN (jetty-launcher-1046-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@13b204ce[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 133192 WARN (jetty-launcher-1046-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@13b204ce[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 133195 WARN (jetty-launcher-1046-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@42a8f3b5[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 133195 WARN (jetty-launcher-1046-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@42a8f3b5[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 133196 INFO (jetty-launcher-1046-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41291/solr
[junit4] 2> 133204 INFO (jetty-launcher-1046-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 133213 INFO (zkConnectionManagerCallback-1076-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 133213 INFO (jetty-launcher-1046-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 133439 INFO (jetty-launcher-1046-thread-2) [n:127.0.0.1:36691_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 133446 INFO (jetty-launcher-1046-thread-1) [n:127.0.0.1:38791_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:38791_solr
[junit4] 2> 133447 INFO (jetty-launcher-1046-thread-1) [n:127.0.0.1:38791_solr ] o.a.s.c.Overseer Overseer (id=72847537987190790-127.0.0.1:38791_solr-n_0000000000) starting
[junit4] 2> 133449 INFO (zkConnectionManagerCallback-1078-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 133449 INFO (jetty-launcher-1046-thread-2) [n:127.0.0.1:36691_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 133453 INFO (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:38791_solr
[junit4] 2> 133459 INFO (jetty-launcher-1046-thread-2) [n:127.0.0.1:36691_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:36691_solr
[junit4] 2> 133460 INFO (jetty-launcher-1046-thread-1) [n:127.0.0.1:38791_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:38791_solr as DOWN
[junit4] 2> 133461 INFO (jetty-launcher-1046-thread-1) [n:127.0.0.1:38791_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 133461 INFO (jetty-launcher-1046-thread-1) [n:127.0.0.1:38791_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:38791_solr
[junit4] 2> 133461 INFO (jetty-launcher-1046-thread-2) [n:127.0.0.1:36691_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 133462 WARN (jetty-launcher-1046-thread-2) [n:127.0.0.1:36691_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> 133465 DEBUG (OverseerAutoScalingTriggerThread-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and .scheduled_maintenance triggers
[junit4] 2> 133466 INFO (jetty-launcher-1046-thread-1) [n:127.0.0.1:38791_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 133466 WARN (jetty-launcher-1046-thread-1) [n:127.0.0.1:38791_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> 133468 DEBUG (OverseerAutoScalingTriggerThread-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1
[junit4] 2> 133469 DEBUG (OverseerAutoScalingTriggerThread-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 0
[junit4] 2> 133469 DEBUG (OverseerAutoScalingTriggerThread-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
[junit4] 2> 133471 INFO (zkCallback-1065-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 133481 INFO (zkCallback-1077-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 133483 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"downnode",
[junit4] 2> "node_name":"127.0.0.1:38791_solr"} current state version: 0
[junit4] 2> 133483 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 127.0.0.1:38791_solr
[junit4] 2> 133483 DEBUG (OverseerAutoScalingTriggerThread-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial livenodes: [127.0.0.1:38791_solr, 127.0.0.1:36691_solr]
[junit4] 2> 133484 INFO (jetty-launcher-1046-thread-2) [n:127.0.0.1:36691_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 133492 DEBUG (ScheduledTrigger-1083-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 133500 DEBUG (OverseerAutoScalingTriggerThread-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded markers
[junit4] 2> 133500 INFO (jetty-launcher-1046-thread-1) [n:127.0.0.1:38791_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 133500 DEBUG (OverseerAutoScalingTriggerThread-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
[junit4] 2> 133525 INFO (jetty-launcher-1046-thread-2) [n:127.0.0.1:36691_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36691.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@442003b5
[junit4] 2> 133526 INFO (jetty-launcher-1046-thread-1) [n:127.0.0.1:38791_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38791.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@442003b5
[junit4] 2> 133535 INFO (jetty-launcher-1046-thread-2) [n:127.0.0.1:36691_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36691.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@442003b5
[junit4] 2> 133535 INFO (jetty-launcher-1046-thread-2) [n:127.0.0.1:36691_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36691.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@442003b5
[junit4] 2> 133535 INFO (jetty-launcher-1046-thread-1) [n:127.0.0.1:38791_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38791.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@442003b5
[junit4] 2> 133536 INFO (jetty-launcher-1046-thread-1) [n:127.0.0.1:38791_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38791.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@442003b5
[junit4] 2> 133536 INFO (jetty-launcher-1046-thread-2) [n:127.0.0.1:36691_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_D891DE97CCD73041-001/tempDir-001/node2
[junit4] 2> 133537 INFO (jetty-launcher-1046-thread-1) [n:127.0.0.1:38791_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_D891DE97CCD73041-001/tempDir-001/node1
[junit4] 2> 133560 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2
[junit4] 2> 133564 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 133565 INFO (zkConnectionManagerCallback-1101-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 133565 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 133566 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 133567 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:41291/solr ready
[junit4] 2> 133579 INFO (OverseerThreadFactory-1085-thread-1-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection .system
[junit4] 2> 133582 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
[junit4] 2> "name":".system",
[junit4] 2> "fromApi":"true",
[junit4] 2> "numShards":1,
[junit4] 2> "createNodeSet":"127.0.0.1:38791_solr",
[junit4] 2> "nrtReplicas":"1",
[junit4] 2> "stateFormat":"2",
[junit4] 2> "replicationFactor":"1",
[junit4] 2> "operation":"create"} current state version: 0
[junit4] 2> 133582 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.ClusterStateMutator building a new cName: .system
[junit4] 2> 133582 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/.system/state.json
[junit4] 2> 133703 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":".system",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:38791_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 133703 INFO (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":".system",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:38791_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 133704 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{}}
[junit4] 2> 133704 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_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> "node_name":"127.0.0.1:38791_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 133804 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 0
[junit4] 2> 133907 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_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> 133909 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.c.ZkStateReader already watching , added to stateWatchers
[junit4] 2> 133912 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_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:38791_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> 133912 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_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:38791_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> 133912 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_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:38791_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "base_url":"http://127.0.0.1:38791/solr"}
[junit4] 2> 133912 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_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:38791_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}}}}}
[junit4] 2> 133918 WARN (qtp1355489178-1737) [n:127.0.0.1:38791_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> 133918 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
[junit4] 2> 133923 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_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> 133925 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_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> 133925 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_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> 133927 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_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> 133929 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_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> 133929 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_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> 133929 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38791.solr.core..system.shard1.replica_n1' (registry 'solr.core..system.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@442003b5
[junit4] 2> 133930 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SolrCore [[.system_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_D891DE97CCD73041-001/tempDir-001/node1/.system_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_D891DE97CCD73041-001/tempDir-001/node1/.system_shard1_replica_n1/data/]
[junit4] 2> 134010 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_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> 134010 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_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> 134012 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_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> 134012 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 134013 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 1
[junit4] 2> 134015 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_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> 134015 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_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> 134015 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_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> 134016 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_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> 134016 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_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> 134016 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_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 1689263842816688128
[junit4] 2> 134018 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.c.ZkStateReader already watching , added to stateWatchers
[junit4] 2> 134025 INFO (searcherExecutor-1103-thread-1-processing-n:127.0.0.1:38791_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node2) [n:127.0.0.1:38791_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> 134025 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_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> 134025 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_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> 134031 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_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> 134032 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_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> 134032 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:38791/solr/.system_shard1_replica_n1/
[junit4] 2> 134032 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_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> 134033 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SyncStrategy http://127.0.0.1:38791/solr/.system_shard1_replica_n1/ has no replicas
[junit4] 2> 134033 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_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/72847537987190790-core_node2-n_0000000000
[junit4] 2> 134036 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:38791/solr/.system_shard1_replica_n1/ shard1
[junit4] 2> 134036 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":".system",
[junit4] 2> "node_name":"127.0.0.1:38791_solr",
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "state":"active"} current state version: 0
[junit4] 2> 134036 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.c.ZkStateReader already watching , added to stateWatchers
[junit4] 2> 134137 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 2
[junit4] 2> 134138 INFO (zkCallback-1065-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> 134138 INFO (zkCallback-1065-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> 134139 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_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> 134141 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_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:38791_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> 134141 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.c.ZkStateReader already watching , added to stateWatchers
[junit4] 2> 134141 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_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:38791_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> 134141 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_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:38791_solr",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "leader":"true",
[junit4] 2> "base_url":"http://127.0.0.1:38791/solr"}
[junit4] 2> 134141 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(.system//collections/.system/state.json/3 )={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"1",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"1",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"1",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node2":{
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "leader":"true",
[junit4] 2> "node_name":"127.0.0.1:38791_solr",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}}}}}
[junit4] 2> 134142 INFO (qtp1355489178-1737) [n:127.0.0.1:38791_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=236
[junit4] 2> 134144 INFO (qtp1113454258-1731) [n:127.0.0.1:36691_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> 134144 INFO (qtp1113454258-1731) [n:127.0.0.1:36691_solr ] o.a.s.c.c.ZkStateReader already watching , added to stateWatchers
[junit4] 2> 134241 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 3
[junit4] 2> 134243 INFO (zkCallback-1065-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> 134243 INFO (zkCallback-1065-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> 134243 INFO (zkCallback-1077-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> 134243 INFO (zkCallback-1065-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> 134244 INFO (qtp1113454258-1731) [n:127.0.0.1:36691_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:38791_solr&wt=javabin&version=2} status=0 QTime=671
[junit4] 2> 134245 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection: .system
[junit4] 2> 134246 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.c.c.ZkStateReader already watching , added to stateWatchers
[junit4] 2> 134366 INFO (OverseerCollectionConfigSetProcessor-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_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> 134368 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection AutoscalingHistoryHandlerTest_collection
[junit4] 2> 134368 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED
[junit4] 2> 134371 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/protwords.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/protwords.txt
[junit4] 2> 134373 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/managed-schema to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/managed-schema
[junit4] 2> 134375 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/solrconfig.xml to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/solrconfig.xml
[junit4] 2> 134377 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134378 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134379 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134381 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134382 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134384 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134386 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134389 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134392 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134394 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134395 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134397 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134398 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134399 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134401 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134402 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134403 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134405 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134406 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134407 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134408 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134411 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134413 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134415 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134416 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134417 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134419 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134420 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134421 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134423 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134425 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134426 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134427 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134431 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134437 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134440 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134443 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134444 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134445 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134447 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/synonyms.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/synonyms.txt
[junit4] 2> 134448 INFO (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/stopwords.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/stopwords.txt
[junit4] 2> 134453 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_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:36691_solr",
[junit4] 2> "nrtReplicas":"3",
[junit4] 2> "stateFormat":"2",
[junit4] 2> "replicationFactor":"3",
[junit4] 2> "operation":"create"} current state version: 0
[junit4] 2> 134453 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.ClusterStateMutator building a new cName: AutoscalingHistoryHandlerTest_collection
[junit4] 2> 134496 DEBUG (ScheduledTrigger-1083-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 2
[junit4] 2> 134554 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/AutoscalingHistoryHandlerTest_collection/state.json
[junit4] 2> 134654 WARN (OverseerThreadFactory-1085-thread-2-processing-n:127.0.0.1:38791_solr) [n:127.0.0.1:38791_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> 134659 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:36691_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 134659 INFO (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:36691_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 134661 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{}}
[junit4] 2> 134661 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node2":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:36691_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 134664 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n3",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:36691_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 134664 INFO (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n3",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:36691_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 134666 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node2":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:36691_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 134666 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node2":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:36691_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"},
[junit4] 2> "core_node5":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n3",
[junit4] 2> "node_name":"127.0.0.1:36691_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 134669 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.Overseer processMessage: queueSize: 3, message = {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:36691_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 134669 INFO (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"AutoscalingHistoryHandlerTest_collection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:36691_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 134673 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node2":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:36691_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"},
[junit4] 2> "core_node5":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n3",
[junit4] 2> "node_name":"127.0.0.1:36691_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 134673 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node2":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:36691_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"},
[junit4] 2> "core_node5":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n3",
[junit4] 2> "node_name":"127.0.0.1:36691_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"},
[junit4] 2> "core_node6":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
[junit4] 2> "node_name":"127.0.0.1:36691_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 134773 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/AutoscalingHistoryHandlerTest_collection/state.json version: 0
[junit4] 2> 134873 INFO (qtp1113454258-1734) [n:127.0.0.1:36691_solr x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node2&collection.configName=AutoscalingHistoryHandlerTest_collection.AUTOCREATED&newCollection=true&name=AutoscalingHistoryHandlerTest_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=AutoscalingHistoryHandlerTest_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 134873 INFO (qtp1113454258-1734) [n:127.0.0.1:36691_solr x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 134873 INFO (qtp1113454258-1731) [n:127.0.0.1:36691_solr x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n3 ] 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_n3&action=CREATE&numShards=1&collection=AutoscalingHistoryHandlerTest_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 134874 INFO (qtp1113454258-1730) [n:127.0.0.1:36691_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> 134876 INFO (qtp1113454258-1734) [n:127.0.0.1:36691_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node2 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1 ] o.a.s.c.c.ZkStateReader already watching , added to stateWatchers
[junit4] 2> 134878 INFO (qtp1113454258-1730) [n:127.0.0.1:36691_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node6 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n4 ] o.a.s.c.c.ZkStateReader already watching , added to stateWatchers
[junit4] 2> 134879 INFO (qtp1113454258-1731) [n:127.0.0.1:36691_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node5 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n3 ] o.a.s.c.c.ZkStateReader already watching , added to stateWatchers
[junit4] 2> 134880 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node2",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:36691_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> 134880 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node2",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:36691_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> 134880 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node2:{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:36691_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "base_url":"http://127.0.0.1:36691/solr"}
[junit4] 2> 134880 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(AutoscalingHistoryHandlerTest_collection//collections/AutoscalingHistoryHandlerTest_collection/state.json/1 )={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"3",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"3",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"3",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node2":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:36691_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_n3",
[junit4] 2> "node_name":"127.0.0.1:36691_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"},
[junit4] 2> "core_node6":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
[junit4] 2> "node_name":"127.0.0.1:36691_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"}}}}}
[junit4] 2> 134888 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n3",
[junit4] 2> "core_node_name":"core_node5",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:36691_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> 134888 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n3",
[junit4] 2> "core_node_name":"core_node5",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:36691_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> 134888 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node5:{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n3",
[junit4] 2> "node_name":"127.0.0.1:36691_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "base_url":"http://127.0.0.1:36691/solr"}
[junit4] 2> 134888 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(AutoscalingHistoryHandlerTest_collection//collections/AutoscalingHistoryHandlerTest_collection/state.json/1 )={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"3",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"3",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"3",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node2":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:36691_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_n3",
[junit4] 2> "node_name":"127.0.0.1:36691_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> "node_name":"127.0.0.1:36691_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"}}}}}
[junit4] 2> 134896 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_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:36691_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> 134896 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=1 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:36691_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> 134896 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node6:{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
[junit4] 2> "node_name":"127.0.0.1:36691_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "base_url":"http://127.0.0.1:36691/solr"}
[junit4] 2> 134896 DEBUG (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(AutoscalingHistoryHandlerTest_collection//collections/AutoscalingHistoryHandlerTest_collection/state.json/1 )={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"3",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"3",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"3",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node2":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "node_name":"127.0.0.1:36691_solr",
[junit4] 2> "state":"down",
[...truncated too long message...]
ost_trigger after 5000ms
[junit4] 2> 199454 DEBUG (AutoscalingActionExecutor-1084-thread-1) [ ] o.a.s.c.a.ScheduledTriggers Resuming trigger: .scheduled_maintenance after 5000ms
[junit4] 2> 199454 DEBUG (AutoscalingActionExecutor-1084-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -- processing took 57 ms for event id=2ad2bc4846aa5dT2irl4im11l282tthlhxae7zq8
[junit4] 2> 199457 INFO (jetty-closer-1153-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
[junit4] 2> 199457 INFO (jetty-closer-1153-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@51630bea: rootName = solr_38791, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@cb93a61
[junit4] 2> 199462 INFO (jetty-closer-1153-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
[junit4] 2> 199463 INFO (jetty-closer-1153-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@171d8749: rootName = solr_38791, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@62ebd8c0
[junit4] 2> 199464 INFO (jetty-closer-1153-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 199464 INFO (jetty-closer-1153-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@20e628fa: rootName = solr_38791, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@575f738d
[junit4] 2> 199465 INFO (jetty-closer-1153-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster tag=null
[junit4] 2> 199484 INFO (closeThreadPool-1170-thread-2) [ ] o.a.s.c.Overseer Overseer (id=72847537987190790-127.0.0.1:38791_solr-n_0000000000) closing
[junit4] 2> 199494 INFO (OverseerStateUpdate-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [n:127.0.0.1:38791_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:38791_solr
[junit4] 2> 199496 INFO (OverseerAutoScalingTriggerThread-72847537987190790-127.0.0.1:38791_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 199497 DEBUG (closeThreadPool-1170-thread-2) [ ] o.a.s.c.a.ScheduledTriggers Shutting down scheduled thread pool executor now
[junit4] 2> 199497 DEBUG (closeThreadPool-1170-thread-2) [ ] o.a.s.c.a.ScheduledTriggers Shutting down action executor now
[junit4] 2> 199497 DEBUG (closeThreadPool-1170-thread-2) [ ] o.a.s.c.a.ScheduledTriggers Awaiting termination for action executor
[junit4] 2> 199499 DEBUG (closeThreadPool-1170-thread-2) [ ] o.a.s.c.a.ScheduledTriggers Awaiting termination for scheduled thread pool executor
[junit4] 2> 199499 DEBUG (closeThreadPool-1170-thread-2) [ ] o.a.s.c.a.ScheduledTriggers ScheduledTriggers closed completely
[junit4] 2> 199499 DEBUG (closeThreadPool-1170-thread-2) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
[junit4] 2> 199499 INFO (closeThreadPool-1170-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72847537987190790-127.0.0.1:38791_solr-n_0000000000) closing
[junit4] 2> 199499 WARN (jetty-launcher-1046-thread-1-SendThread(127.0.0.1:41291)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x102ce73287d0006.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x102ce73287d0006, 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 0x102ce73287d0006, 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> 199558 INFO (jetty-closer-1153-thread-2) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@4c9a0089{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 199559 INFO (jetty-closer-1153-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1851f6f9{/solr,null,STOPPED}
[junit4] 2> 199559 INFO (jetty-closer-1153-thread-2) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 199599 INFO (jetty-closer-1153-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72847537987190790-127.0.0.1:38791_solr-n_0000000000) closing
[junit4] 2> 199600 INFO (jetty-closer-1153-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@5e0cebf3{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 199601 INFO (jetty-closer-1153-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5a701d2a{/solr,null,STOPPED}
[junit4] 2> 199601 INFO (jetty-closer-1153-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 199602 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 199603 WARN (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker-SendThread(127.0.0.1:41291)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x102ce73287d0000.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x102ce73287d0000, 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 0x102ce73287d0000, 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> 199806 WARN (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 5 /solr/clusterprops.json
[junit4] 2> 5 /solr/aliases.json
[junit4] 2> 4 /solr/collections/AutoscalingHistoryHandlerTest_collection/terms/shard1
[junit4] 2> 3 /solr/packages.json
[junit4] 2> 3 /solr/security.json
[junit4] 2> 3 /solr/collections/.system/terms/shard1
[junit4] 2> 3 /solr/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/managed-schema
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 20 /solr/collections/AutoscalingHistoryHandlerTest_collection/state.json
[junit4] 2> 16 /solr/collections/.system/state.json
[junit4] 2> 12 /solr/autoscaling.json
[junit4] 2> 5 /solr/clusterstate.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 35 /solr/overseer/queue
[junit4] 2> 16 /solr/live_nodes
[junit4] 2> 11 /solr/collections
[junit4] 2> 9 /solr/collections/AutoscalingHistoryHandlerTest_collection/state.json
[junit4] 2> 8 /solr/overseer/collection-queue-work
[junit4] 2> 7 /solr/collections/.system/state.json
[junit4] 2>
[junit4] 2> 199810 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:41291
[junit4] 2> 199810 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:41291
[junit4] 2> 199810 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[D891DE97CCD73041]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 41291
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_D891DE97CCD73041-001
[junit4] 2> Jan 18, 2021 10:06:46 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Lucene87, sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=da-DK, timezone=Asia/Jayapura
[junit4] 2> NOTE: Linux 4.15.0-112-generic amd64/Oracle Corporation 1.8.0_252 (64-bit)/cpus=4,threads=1,free=284944184,total=519569408
[junit4] 2> NOTE: All tests run in this JVM: [TestConfigSetImmutable, CoreAdminRequestStatusTest, TestNumericTokenStream, SolrMetricsIntegrationTest, TestSchemaVersionResource, ForceLeaderTest, AnalyticsMergeStrategyTest, OverseerModifyCollectionTest, TestManagedSchemaAPI, RegexBoostProcessorTest, BlockCacheTest, DirectSolrConnectionTest, MoveReplicaTest, CloneFieldUpdateProcessorFactoryTest, TestCursorMarkWithoutUniqueKey, ConvertedLegacyTest, TestRestManager, TestRandomDVFaceting, TestBM25SimilarityFactory, AutoscalingHistoryHandlerTest]
[junit4] Completed [108/923 (1!)] on J2 in 67.96s, 1 test, 1 failure <<< FAILURES!
[...truncated 53526 lines...]