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 2020/11/17 08:58:34 UTC
[JENKINS] Lucene » Lucene-Solr-BadApples-Tests-8.x - Build # 101 - Unstable!
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-BadApples-Tests-8.x/101/
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([801ADBCE8DBFEFC5:EDE67F3337F710C2]: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 14578 lines...]
[junit4] Suite: org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest
[junit4] 2> 1059346 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/server/solr/configsets/_default/conf'
[junit4] 2> 1059346 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1059348 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_801ADBCE8DBFEFC5-001/data-dir-84-001
[junit4] 2> 1059348 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 1059350 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-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> 1059351 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_801ADBCE8DBFEFC5-001/tempDir-001
[junit4] 2> 1059351 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1059354 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 1059354 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1059355 WARN (ZkTestServer Run Thread) [ ] o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
[junit4] 2> 1059454 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port: 42623
[junit4] 2> 1059454 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-worker) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:42623
[junit4] 2> 1059454 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:42623
[junit4] 2> 1059454 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 42623
[junit4] 2> 1059488 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1059492 INFO (zkConnectionManagerCallback-11730-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1059492 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1059554 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1059564 INFO (zkConnectionManagerCallback-11732-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1059564 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1059565 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1059590 INFO (zkConnectionManagerCallback-11734-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1059591 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1059592 WARN (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-worker-SendThread(127.0.0.1:42623)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x1018c34a8aa0002.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x1018c34a8aa0002, 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 0x1018c34a8aa0002, 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> 1059695 INFO (jetty-launcher-11735-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1059695 INFO (jetty-launcher-11735-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1059695 INFO (jetty-launcher-11735-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> 1059699 INFO (jetty-launcher-11735-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1059699 INFO (jetty-launcher-11735-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1059699 INFO (jetty-launcher-11735-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> 1059700 INFO (jetty-launcher-11735-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1059700 INFO (jetty-launcher-11735-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1059700 INFO (jetty-launcher-11735-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1059701 INFO (jetty-launcher-11735-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1059701 INFO (jetty-launcher-11735-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1059701 INFO (jetty-launcher-11735-thread-2) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1059701 INFO (jetty-launcher-11735-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5e10d97d{/solr,null,AVAILABLE}
[junit4] 2> 1059702 INFO (jetty-launcher-11735-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2d461f95{/solr,null,AVAILABLE}
[junit4] 2> 1059702 INFO (jetty-launcher-11735-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@34cecd3b{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:43285}
[junit4] 2> 1059702 INFO (jetty-launcher-11735-thread-2) [ ] o.e.j.s.Server Started @1059731ms
[junit4] 2> 1059702 INFO (jetty-launcher-11735-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=43285}
[junit4] 2> 1059702 ERROR (jetty-launcher-11735-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1059702 INFO (jetty-launcher-11735-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1059702 INFO (jetty-launcher-11735-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.8.0
[junit4] 2> 1059702 INFO (jetty-launcher-11735-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1059702 INFO (jetty-launcher-11735-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr
[junit4] 2> 1059702 INFO (jetty-launcher-11735-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-11-17T08:17:15.446Z
[junit4] 2> 1059705 INFO (jetty-launcher-11735-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1059705 INFO (jetty-launcher-11735-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@a8389f8{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:41781}
[junit4] 2> 1059705 INFO (jetty-launcher-11735-thread-1) [ ] o.e.j.s.Server Started @1059735ms
[junit4] 2> 1059705 INFO (jetty-launcher-11735-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=41781}
[junit4] 2> 1059706 ERROR (jetty-launcher-11735-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1059706 INFO (jetty-launcher-11735-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1059706 INFO (jetty-launcher-11735-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.8.0
[junit4] 2> 1059706 INFO (jetty-launcher-11735-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1059706 INFO (jetty-launcher-11735-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr
[junit4] 2> 1059706 INFO (jetty-launcher-11735-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-11-17T08:17:15.450Z
[junit4] 2> 1059707 INFO (jetty-launcher-11735-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1059707 INFO (zkConnectionManagerCallback-11737-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1059707 INFO (jetty-launcher-11735-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1059707 INFO (jetty-launcher-11735-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1059726 INFO (zkConnectionManagerCallback-11739-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1059727 INFO (jetty-launcher-11735-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1059729 INFO (jetty-launcher-11735-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1059730 WARN (jetty-launcher-11735-thread-2-SendThread(127.0.0.1:42623)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x1018c34a8aa0003.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x1018c34a8aa0003, 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 0x1018c34a8aa0003, 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> 1060863 INFO (jetty-launcher-11735-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1060890 WARN (jetty-launcher-11735-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@3a8817cd[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1060890 WARN (jetty-launcher-11735-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@3a8817cd[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1060907 WARN (jetty-launcher-11735-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@68945ec2[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1060907 WARN (jetty-launcher-11735-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@68945ec2[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1060908 INFO (jetty-launcher-11735-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42623/solr
[junit4] 2> 1060922 INFO (jetty-launcher-11735-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1060926 INFO (zkConnectionManagerCallback-11753-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1060926 INFO (jetty-launcher-11735-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1060929 WARN (jetty-launcher-11735-thread-2-SendThread(127.0.0.1:42623)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x1018c34a8aa0005.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x1018c34a8aa0005, 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 0x1018c34a8aa0005, 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> 1060970 INFO (jetty-launcher-11735-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 1060979 WARN (jetty-launcher-11735-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@5369ac28[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1060980 WARN (jetty-launcher-11735-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@5369ac28[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1061009 WARN (jetty-launcher-11735-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@2d2f394[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1061009 WARN (jetty-launcher-11735-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@2d2f394[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1061010 INFO (jetty-launcher-11735-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42623/solr
[junit4] 2> 1061028 INFO (jetty-launcher-11735-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1061034 INFO (zkConnectionManagerCallback-11761-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1061034 INFO (jetty-launcher-11735-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1061046 INFO (jetty-launcher-11735-thread-2) [n:127.0.0.1:43285_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1061054 INFO (zkConnectionManagerCallback-11763-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1061054 INFO (jetty-launcher-11735-thread-2) [n:127.0.0.1:43285_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1061126 INFO (jetty-launcher-11735-thread-2) [n:127.0.0.1:43285_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:43285_solr
[junit4] 2> 1061126 INFO (jetty-launcher-11735-thread-2) [n:127.0.0.1:43285_solr ] o.a.s.c.Overseer Overseer (id=72493226810540039-127.0.0.1:43285_solr-n_0000000000) starting
[junit4] 2> 1061162 INFO (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:43285_solr
[junit4] 2> 1061167 INFO (jetty-launcher-11735-thread-2) [n:127.0.0.1:43285_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:43285_solr
[junit4] 2> 1061168 DEBUG (OverseerAutoScalingTriggerThread-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and .scheduled_maintenance triggers
[junit4] 2> 1061169 DEBUG (OverseerAutoScalingTriggerThread-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1
[junit4] 2> 1061169 INFO (jetty-launcher-11735-thread-2) [n:127.0.0.1:43285_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 1061169 DEBUG (OverseerAutoScalingTriggerThread-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 0
[junit4] 2> 1061169 DEBUG (OverseerAutoScalingTriggerThread-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
[junit4] 2> 1061170 WARN (jetty-launcher-11735-thread-2) [n:127.0.0.1:43285_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> 1061185 INFO (jetty-launcher-11735-thread-1) [n:127.0.0.1:41781_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1061211 DEBUG (OverseerAutoScalingTriggerThread-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial livenodes: []
[junit4] 2> 1061222 DEBUG (OverseerAutoScalingTriggerThread-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded markers
[junit4] 2> 1061222 INFO (jetty-launcher-11735-thread-2) [n:127.0.0.1:43285_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1061222 INFO (zkCallback-11762-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1061226 DEBUG (OverseerAutoScalingTriggerThread-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
[junit4] 2> 1061230 INFO (zkConnectionManagerCallback-11772-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1061230 DEBUG (ScheduledTrigger-11768-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 and last live nodes: 0
[junit4] 2> 1061230 INFO (jetty-launcher-11735-thread-1) [n:127.0.0.1:41781_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1061234 INFO (jetty-launcher-11735-thread-1) [n:127.0.0.1:41781_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1061237 INFO (jetty-launcher-11735-thread-1) [n:127.0.0.1:41781_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:41781_solr as DOWN
[junit4] 2> 1061238 INFO (jetty-launcher-11735-thread-1) [n:127.0.0.1:41781_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1061238 INFO (jetty-launcher-11735-thread-1) [n:127.0.0.1:41781_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:41781_solr
[junit4] 2> 1061241 INFO (zkCallback-11771-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1061241 INFO (zkCallback-11762-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1061242 INFO (jetty-launcher-11735-thread-1) [n:127.0.0.1:41781_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 1061242 WARN (jetty-launcher-11735-thread-1) [n:127.0.0.1:41781_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> 1061247 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"downnode",
[junit4] 2> "node_name":"127.0.0.1:41781_solr"} current state version: 0
[junit4] 2> 1061247 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 127.0.0.1:41781_solr
[junit4] 2> 1061263 INFO (jetty-launcher-11735-thread-1) [n:127.0.0.1:41781_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1061289 INFO (jetty-launcher-11735-thread-2) [n:127.0.0.1:43285_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43285.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@74577471
[junit4] 2> 1061301 INFO (jetty-launcher-11735-thread-1) [n:127.0.0.1:41781_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41781.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@74577471
[junit4] 2> 1061308 INFO (jetty-launcher-11735-thread-2) [n:127.0.0.1:43285_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43285.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@74577471
[junit4] 2> 1061308 INFO (jetty-launcher-11735-thread-2) [n:127.0.0.1:43285_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43285.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@74577471
[junit4] 2> 1061309 INFO (jetty-launcher-11735-thread-2) [n:127.0.0.1:43285_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_801ADBCE8DBFEFC5-001/tempDir-001/node2
[junit4] 2> 1061312 INFO (jetty-launcher-11735-thread-1) [n:127.0.0.1:41781_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41781.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@74577471
[junit4] 2> 1061312 INFO (jetty-launcher-11735-thread-1) [n:127.0.0.1:41781_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41781.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@74577471
[junit4] 2> 1061313 INFO (jetty-launcher-11735-thread-1) [n:127.0.0.1:41781_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_801ADBCE8DBFEFC5-001/tempDir-001/node1
[junit4] 2> 1061338 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-worker) [ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2
[junit4] 2> 1061339 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1061342 INFO (zkConnectionManagerCallback-11790-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1061342 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1061344 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1061345 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42623/solr ready
[junit4] 2> 1061369 INFO (OverseerThreadFactory-11770-thread-1-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection .system
[junit4] 2> 1061372 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "name":".system",
[junit4] 2> "fromApi":"true",
[junit4] 2> "numShards":1,
[junit4] 2> "createNodeSet":"127.0.0.1:43285_solr",
[junit4] 2> "nrtReplicas":"1",
[junit4] 2> "stateFormat":"2",
[junit4] 2> "replicationFactor":"1",
[junit4] 2> "operation":"create"} current state version: 0
[junit4] 2> 1061372 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.o.ClusterStateMutator building a new cName: .system
[junit4] 2> 1061372 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/.system/state.json
[junit4] 2> 1061476 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_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> "base_url":"http://127.0.0.1:43285/solr",
[junit4] 2> "node_name":"127.0.0.1:43285_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 1061476 INFO (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_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> "base_url":"http://127.0.0.1:43285/solr",
[junit4] 2> "node_name":"127.0.0.1:43285_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1061477 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{}}
[junit4] 2> 1061477 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_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> "base_url":"http://127.0.0.1:43285/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:43285_solr",
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 1061754 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 0
[junit4] 2> 1061867 INFO (qtp973677578-20420) [n:127.0.0.1:43285_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> 1061867 INFO (qtp973677578-20420) [n:127.0.0.1:43285_solr x:.system_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1061881 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_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> "base_url":"http://127.0.0.1:43285/solr",
[junit4] 2> "node_name":"127.0.0.1:43285_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> 1061882 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_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> "base_url":"http://127.0.0.1:43285/solr",
[junit4] 2> "node_name":"127.0.0.1:43285_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> 1061882 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node2:{
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "base_url":"http://127.0.0.1:43285/solr",
[junit4] 2> "node_name":"127.0.0.1:43285_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}
[junit4] 2> 1061882 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_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> "base_url":"http://127.0.0.1:43285/solr",
[junit4] 2> "node_name":"127.0.0.1:43285_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}}}}}
[junit4] 2> 1061889 WARN (qtp973677578-20420) [n:127.0.0.1:43285_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> 1061889 INFO (qtp973677578-20420) [n:127.0.0.1:43285_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.8.0
[junit4] 2> 1061922 INFO (qtp973677578-20420) [n:127.0.0.1:43285_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> 1061925 INFO (qtp973677578-20420) [n:127.0.0.1:43285_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> 1061928 INFO (qtp973677578-20420) [n:127.0.0.1:43285_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> 1061930 INFO (qtp973677578-20420) [n:127.0.0.1:43285_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> 1061932 INFO (qtp973677578-20420) [n:127.0.0.1:43285_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> 1061933 INFO (qtp973677578-20420) [n:127.0.0.1:43285_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> 1061933 INFO (qtp973677578-20420) [n:127.0.0.1:43285_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_43285.solr.core..system.shard1.replica_n1' (registry 'solr.core..system.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@74577471
[junit4] 2> 1061933 INFO (qtp973677578-20420) [n:127.0.0.1:43285_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SolrCore [[.system_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_801ADBCE8DBFEFC5-001/tempDir-001/node2/.system_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_801ADBCE8DBFEFC5-001/tempDir-001/node2/.system_shard1_replica_n1/data/]
[junit4] 2> 1061982 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 1
[junit4] 2> 1061986 INFO (qtp973677578-20420) [n:127.0.0.1:43285_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> 1061986 INFO (qtp973677578-20420) [n:127.0.0.1:43285_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> 1061987 INFO (qtp973677578-20420) [n:127.0.0.1:43285_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> 1061987 INFO (qtp973677578-20420) [n:127.0.0.1:43285_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1061989 INFO (qtp973677578-20420) [n:127.0.0.1:43285_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> 1061989 INFO (qtp973677578-20420) [n:127.0.0.1:43285_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> 1061989 INFO (qtp973677578-20420) [n:127.0.0.1:43285_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> 1061990 INFO (qtp973677578-20420) [n:127.0.0.1:43285_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> 1061990 INFO (qtp973677578-20420) [n:127.0.0.1:43285_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> 1061990 INFO (qtp973677578-20420) [n:127.0.0.1:43285_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 1683594713742966784
[junit4] 2> 1061993 INFO (searcherExecutor-11792-thread-1-processing-n:127.0.0.1:43285_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node2) [n:127.0.0.1:43285_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> 1061997 INFO (qtp973677578-20420) [n:127.0.0.1:43285_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> 1061999 INFO (qtp973677578-20420) [n:127.0.0.1:43285_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> 1062002 INFO (qtp973677578-20420) [n:127.0.0.1:43285_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> 1062002 INFO (qtp973677578-20420) [n:127.0.0.1:43285_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> 1062002 INFO (qtp973677578-20420) [n:127.0.0.1:43285_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:43285/solr/.system_shard1_replica_n1/
[junit4] 2> 1062002 INFO (qtp973677578-20420) [n:127.0.0.1:43285_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> 1062002 INFO (qtp973677578-20420) [n:127.0.0.1:43285_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SyncStrategy http://127.0.0.1:43285/solr/.system_shard1_replica_n1/ has no replicas
[junit4] 2> 1062002 INFO (qtp973677578-20420) [n:127.0.0.1:43285_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/72493226810540039-core_node2-n_0000000000
[junit4] 2> 1062004 INFO (qtp973677578-20420) [n:127.0.0.1:43285_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:43285/solr/.system_shard1_replica_n1/ shard1
[junit4] 2> 1062004 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":".system",
[junit4] 2> "base_url":"http://127.0.0.1:43285/solr",
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "state":"active"} current state version: 0
[junit4] 2> 1062217 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 2
[junit4] 2> 1062218 INFO (zkCallback-11762-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> 1062218 INFO (zkCallback-11762-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> 1062219 INFO (qtp973677578-20420) [n:127.0.0.1:43285_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> 1062220 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_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> "base_url":"http://127.0.0.1:43285/solr",
[junit4] 2> "node_name":"127.0.0.1:43285_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> 1062220 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_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> "base_url":"http://127.0.0.1:43285/solr",
[junit4] 2> "node_name":"127.0.0.1:43285_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> 1062220 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node2:{
[junit4] 2> "core":".system_shard1_replica_n1",
[junit4] 2> "base_url":"http://127.0.0.1:43285/solr",
[junit4] 2> "node_name":"127.0.0.1:43285_solr",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "leader":"true"}
[junit4] 2> 1062220 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_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> "base_url":"http://127.0.0.1:43285/solr",
[junit4] 2> "node_name":"127.0.0.1:43285_solr",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "leader":"true"}}}}}
[junit4] 2> 1062222 INFO (qtp973677578-20420) [n:127.0.0.1:43285_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=355
[junit4] 2> 1062224 INFO (qtp71595776-20411) [n:127.0.0.1:41781_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> 1062232 DEBUG (ScheduledTrigger-11768-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 1
[junit4] 2> 1062321 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 3
[junit4] 2> 1062322 INFO (zkCallback-11762-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> 1062322 INFO (zkCallback-11762-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> 1062322 INFO (zkCallback-11771-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> 1062322 INFO (zkCallback-11762-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> 1062322 INFO (qtp71595776-20411) [n:127.0.0.1:41781_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:43285_solr&wt=javabin&version=2} status=0 QTime=972
[junit4] 2> 1062323 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-worker) [ ] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection: .system
[junit4] 2> 1062330 INFO (OverseerCollectionConfigSetProcessor-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_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> 1062331 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection AutoscalingHistoryHandlerTest_collection
[junit4] 2> 1062332 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED
[junit4] 2> 1062333 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/protwords.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/protwords.txt
[junit4] 2> 1062335 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/managed-schema to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/managed-schema
[junit4] 2> 1062338 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/solrconfig.xml to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/solrconfig.xml
[junit4] 2> 1062341 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062342 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062344 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062345 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062346 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062348 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062349 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062350 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062352 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062353 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062354 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062356 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062357 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062358 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062360 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062361 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062362 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062364 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062365 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062367 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062368 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062370 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062371 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062373 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062381 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062382 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062384 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062385 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062386 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062387 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062388 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062390 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062391 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062392 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062393 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062394 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062395 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062397 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062398 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062399 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/synonyms.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/synonyms.txt
[junit4] 2> 1062400 INFO (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/stopwords.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/stopwords.txt
[junit4] 2> 1062404 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_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:41781_solr",
[junit4] 2> "nrtReplicas":"3",
[junit4] 2> "stateFormat":"2",
[junit4] 2> "replicationFactor":"3",
[junit4] 2> "operation":"create"} current state version: 0
[junit4] 2> 1062404 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.o.ClusterStateMutator building a new cName: AutoscalingHistoryHandlerTest_collection
[junit4] 2> 1062505 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/AutoscalingHistoryHandlerTest_collection/state.json
[junit4] 2> 1062605 WARN (OverseerThreadFactory-11770-thread-2-processing-n:127.0.0.1:43285_solr) [n:127.0.0.1:43285_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> 1062608 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_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> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "node_name":"127.0.0.1:41781_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 1062608 INFO (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_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> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "node_name":"127.0.0.1:41781_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1062610 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{}}
[junit4] 2> 1062610 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node3":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:41781_solr",
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 1062611 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_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_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "node_name":"127.0.0.1:41781_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 1062611 INFO (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_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_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "node_name":"127.0.0.1:41781_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1062614 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node3":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:41781_solr",
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 1062614 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:41781_solr",
[junit4] 2> "type":"NRT"},
[junit4] 2> "core_node5":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:41781_solr",
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 1062615 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_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> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "node_name":"127.0.0.1:41781_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 1062615 INFO (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_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> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "node_name":"127.0.0.1:41781_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 1062616 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:41781_solr",
[junit4] 2> "type":"NRT"},
[junit4] 2> "core_node5":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:41781_solr",
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 1062616 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:41781_solr",
[junit4] 2> "type":"NRT"},
[junit4] 2> "core_node5":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:41781_solr",
[junit4] 2> "type":"NRT"},
[junit4] 2> "core_node6":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
[junit4] 2> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:41781_solr",
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 1062719 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/AutoscalingHistoryHandlerTest_collection/state.json version: 0
[junit4] 2> 1062819 INFO (qtp71595776-20411) [n:127.0.0.1:41781_solr x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=AutoscalingHistoryHandlerTest_collection.AUTOCREATED&newCollection=true&name=AutoscalingHistoryHandlerTest_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=AutoscalingHistoryHandlerTest_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1062819 INFO (qtp71595776-20410) [n:127.0.0.1:41781_solr x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n2 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node5&collection.configName=AutoscalingHistoryHandlerTest_collection.AUTOCREATED&newCollection=true&name=AutoscalingHistoryHandlerTest_collection_shard1_replica_n2&action=CREATE&numShards=1&collection=AutoscalingHistoryHandlerTest_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1062819 INFO (qtp71595776-20414) [n:127.0.0.1:41781_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> 1062824 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node3",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "node_name":"127.0.0.1:41781_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> 1062825 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node3",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "node_name":"127.0.0.1:41781_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> 1062825 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node3:{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "node_name":"127.0.0.1:41781_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}
[junit4] 2> 1062825 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(AutoscalingHistoryHandlerTest_collection//collections/AutoscalingHistoryHandlerTest_collection/state.json/1)={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"3",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"3",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"3",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "node_name":"127.0.0.1:41781_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"},
[junit4] 2> "core_node5":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:41781_solr",
[junit4] 2> "type":"NRT"},
[junit4] 2> "core_node6":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
[junit4] 2> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:41781_solr",
[junit4] 2> "type":"NRT"}}}}}
[junit4] 2> 1062825 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
[junit4] 2> "core_node_name":"core_node6",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "node_name":"127.0.0.1:41781_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> 1062825 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_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> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "node_name":"127.0.0.1:41781_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> 1062825 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node6:{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
[junit4] 2> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "node_name":"127.0.0.1:41781_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}
[junit4] 2> 1062825 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(AutoscalingHistoryHandlerTest_collection//collections/AutoscalingHistoryHandlerTest_collection/state.json/1)={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"3",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"3",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"3",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
[junit4] 2> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "node_name":"127.0.0.1:41781_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"},
[junit4] 2> "core_node5":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:41781_solr",
[junit4] 2> "type":"NRT"},
[junit4] 2> "core_node6":{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
[junit4] 2> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "node_name":"127.0.0.1:41781_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}}}}}
[junit4] 2> 1062825 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.Overseer processMessage: queueSize: 3, message = {
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "core_node_name":"core_node5",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "node_name":"127.0.0.1:41781_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> 1062826 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "core_node_name":"core_node5",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "node_name":"127.0.0.1:41781_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> 1062826 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node5:{
[junit4] 2> "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
[junit4] 2> "base_url":"http://127.0.0.1:41781/solr",
[junit4] 2> "node_name":"127.0.0.1:41781_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}
[junit4] 2> 1062826 DEBUG (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(AutoscalingHistoryHandlerTest_collection//collections/AutoscalingHistoryHandlerTest_collection/state.json/1)
[...truncated too long message...]
[junit4] 2> 1128736 INFO (jetty-closer-11842-thread-3) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@14315ce0{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 1128736 INFO (jetty-closer-11842-thread-3) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5b295c80{/solr,null,STOPPED}
[junit4] 2> 1128737 INFO (jetty-closer-11842-thread-3) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1128835 WARN (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.Overseer Solr cannot talk to ZK, exiting Overseer main queue loop
[junit4] 2> => org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /collections/.system/state.json
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:134)
[junit4] 2> org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /collections/.system/state.json
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:134) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:54) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ZooKeeper.setData(ZooKeeper.java:2561) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.lambda$setData$6(SolrZkClient.java:351) ~[java/:?]
[junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:71) ~[java/:?]
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.setData(SolrZkClient.java:351) ~[java/:?]
[junit4] 2> at org.apache.solr.cloud.overseer.ZkStateWriter.writePendingUpdates(ZkStateWriter.java:201) ~[java/:?]
[junit4] 2> at org.apache.solr.cloud.Overseer$ClusterStateUpdater.run(Overseer.java:265) [java/:?]
[junit4] 2> at java.lang.Thread.run(Thread.java:748) [?:1.8.0_252]
[junit4] 2> 1128836 INFO (OverseerStateUpdate-72493226810540039-127.0.0.1:43285_solr-n_0000000000) [n:127.0.0.1:43285_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:43285_solr
[junit4] 2> 1128836 INFO (jetty-closer-11842-thread-2) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@a8389f8{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 1128836 INFO (jetty-closer-11842-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2d461f95{/solr,null,STOPPED}
[junit4] 2> 1128836 INFO (jetty-closer-11842-thread-2) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1128837 INFO (closeThreadPool-11859-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72493226810540039-127.0.0.1:43285_solr-n_0000000000) closing
[junit4] 2> 1128936 INFO (jetty-closer-11842-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72493226810540039-127.0.0.1:43285_solr-n_0000000000) closing
[junit4] 2> 1128937 INFO (jetty-closer-11842-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@34cecd3b{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 1128937 INFO (jetty-closer-11842-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5e10d97d{/solr,null,STOPPED}
[junit4] 2> 1128937 INFO (jetty-closer-11842-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1128938 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-worker) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 1129040 WARN (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-worker-SendThread(127.0.0.1:42623)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x1018c34a8aa0001.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x1018c34a8aa0001, 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 0x1018c34a8aa0001, 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> 1129141 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> 15 /solr/collections/AutoscalingHistoryHandlerTest_collection/state.json
[junit4] 2> 13 /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> 34 /solr/overseer/queue
[junit4] 2> 17 /solr/live_nodes
[junit4] 2> 11 /solr/collections
[junit4] 2> 9 /solr/overseer/collection-queue-work
[junit4] 2>
[junit4] 2> 1129144 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-worker) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:42623
[junit4] 2> 1129144 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:42623
[junit4] 2> 1129144 INFO (SUITE-AutoscalingHistoryHandlerTest-seed#[801ADBCE8DBFEFC5]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 42623
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J0/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_801ADBCE8DBFEFC5-001
[junit4] 2> Nov 17, 2020 8:18:25 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene87): {action_s=PostingsFormat(name=MockRandom), event.property.preferredOperation_ss=BlockTreeOrds(blocksize=128), event.source_s=Lucene84, event.property.replicaType_ss=PostingsFormat(name=MockRandom), type=BlockTreeOrds(blocksize=128), before.actions_ss=PostingsFormat(name=LuceneFixedGap), event.property._enqueue_time__ss=PostingsFormat(name=MockRandom), error.details_t=PostingsFormat(name=LuceneFixedGap), stage_s=PostingsFormat(name=MockRandom), event.id_s=Lucene84, event.property.eventTimes_ss=BlockTreeOrds(blocksize=128), source_s=Lucene84, event.type_s=BlockTreeOrds(blocksize=128), id=Lucene84, event.property.nodeNames_ss=BlockTreeOrds(blocksize=128), error.message_t=BlockTreeOrds(blocksize=128)}, docValues:{_version_=DocValuesFormat(name=Lucene80), event.time_l=DocValuesFormat(name=Lucene80), timestamp=DocValuesFormat(name=Lucene80)}, maxPointsInLeafNode=1734, maxMBSortInHeap=6.405851857002532, sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=ca, timezone=CTT
[junit4] 2> NOTE: Linux 5.4.0-45-generic amd64/Oracle Corporation 1.8.0_252 (64-bit)/cpus=4,threads=1,free=213678192,total=523239424
[junit4] 2> NOTE: All tests run in this JVM: [TestChildDocTransformer, AsyncCallRequestStatusResponseTest, AddSchemaFieldsUpdateProcessorFactoryTest, SolrCLIZkUtilsTest, TestHttpServletCarrier, LeaderFailureAfterFreshStartTest, StatsComponentTest, TestHdfsUpdateLog, TestSimComputePlanAction, HdfsBasicDistributedZkTest, TestSearcherReuse, MoveReplicaHDFSFailoverTest, XMLAtomicUpdateMultivalueTest, DateMathParserTest, TestMergePolicyConfig, TestExactStatsCache, ZkStateWriterTest, TestRecoveryHdfs, TestLFUCache, SearchRateTriggerTest, TestDistributedMissingSort, HttpSolrCallGetCoreTest, HdfsThreadLeakTest, CustomHighlightComponentTest, TestValueSourceCache, PKIAuthenticationIntegrationTest, FullSolrCloudDistribCmdsTest, TestConfigSetsAPIZkFailure, SpatialFilterTest, ClusterStateMockUtilTest, DistributedVersionInfoTest, TestDocSet, BlockDirectoryTest, TestZkChroot, TestRangeQuery, TestRestManager, SolrTestCaseJ4Test, TestCloudJSONFacetSKGEquiv, CategoryRoutedAliasUpdateProcessorTest, TestSubQueryTransformerCrossCore, JavabinLoaderTest, TestPostingsSolrHighlighter, OutputWriterTest, ExplicitHLLTest, TestFuzzyAnalyzedSuggestions, FuzzySearchTest, PluginInfoTest, TestJsonRequest, AnalyticsMergeStrategyTest, TestLuceneIndexBackCompat, CoreAdminRequestStatusTest, TestStressLiveNodes, QueryEqualityTest, TestSchemaVersionResource, DateFieldTest, JavaBinAtomicUpdateMultivalueTest, TestNestedDocsSort, TestClusterProperties, BasicAuthIntegrationTest, DistribCursorPagingTest, CollectionsAPIDistributedZkTest, MetricsDisabledCloudTest, BlockJoinFacetSimpleTest, ZkDynamicConfigTest, RootFieldTest, IndexBasedSpellCheckerTest, TestSafeXMLParsing, DistributedExpandComponentTest, BooleanFieldTest, TestRestoreCore, TestGraphMLResponseWriter, TestCloudPseudoReturnFields, PeerSyncWithBufferUpdatesTest, HttpTriggerListenerTest, SubstringBytesRefFilterTest, AutoscalingHistoryHandlerTest]
[junit4] Completed [402/921 (1!)] on J0 in 70.71s, 1 test, 1 failure <<< FAILURES!
[...truncated 52462 lines...]