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 2019/09/30 01:52:27 UTC
[JENKINS] Lucene-Solr-Tests-master - Build # 3802 - Failure
Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/3802/
1 tests failed.
FAILED: org.apache.solr.cloud.TestUtilizeNode.test
Error Message:
Error from server at https://127.0.0.1:33997/solr: org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /autoscaling.json
Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:33997/solr: org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /autoscaling.json
at __randomizedtesting.SeedInfo.seed([BC09242B5A69A8B7:345D1BF1F495C54F]:0)
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:665)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:265)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
at org.apache.solr.client.solrj.impl.LBSolrClient.doRequest(LBSolrClient.java:368)
at org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:296)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.sendRequest(BaseCloudSolrClient.java:1128)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:897)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:829)
at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1274)
at org.apache.solr.cloud.TestUtilizeNode.test(TestUtilizeNode.java:129)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:566)
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.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 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.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 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 com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:834)
Build Log:
[...truncated 13289 lines...]
[junit4] Suite: org.apache.solr.cloud.TestUtilizeNode
[junit4] 2> 723771 INFO (SUITE-TestUtilizeNode-seed#[BC09242B5A69A8B7]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestUtilizeNode_BC09242B5A69A8B7-001/data-dir-47-001
[junit4] 2> 723771 INFO (SUITE-TestUtilizeNode-seed#[BC09242B5A69A8B7]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 723784 INFO (SUITE-TestUtilizeNode-seed#[BC09242B5A69A8B7]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0)
[junit4] 2> 723785 INFO (SUITE-TestUtilizeNode-seed#[BC09242B5A69A8B7]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 723785 INFO (SUITE-TestUtilizeNode-seed#[BC09242B5A69A8B7]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 3 servers in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestUtilizeNode_BC09242B5A69A8B7-001/tempDir-001
[junit4] 2> 723785 INFO (SUITE-TestUtilizeNode-seed#[BC09242B5A69A8B7]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 723786 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 723786 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 723889 INFO (SUITE-TestUtilizeNode-seed#[BC09242B5A69A8B7]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:33929
[junit4] 2> 723889 INFO (SUITE-TestUtilizeNode-seed#[BC09242B5A69A8B7]-worker) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:33929
[junit4] 2> 723889 INFO (SUITE-TestUtilizeNode-seed#[BC09242B5A69A8B7]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:33929
[junit4] 2> 723889 INFO (SUITE-TestUtilizeNode-seed#[BC09242B5A69A8B7]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 33929
[junit4] 2> 723891 INFO (SUITE-TestUtilizeNode-seed#[BC09242B5A69A8B7]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 723893 INFO (zkConnectionManagerCallback-1916-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 723893 INFO (SUITE-TestUtilizeNode-seed#[BC09242B5A69A8B7]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 723908 INFO (SUITE-TestUtilizeNode-seed#[BC09242B5A69A8B7]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 723909 INFO (zkConnectionManagerCallback-1918-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 723909 INFO (SUITE-TestUtilizeNode-seed#[BC09242B5A69A8B7]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 723918 INFO (SUITE-TestUtilizeNode-seed#[BC09242B5A69A8B7]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 723919 INFO (zkConnectionManagerCallback-1920-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 723919 INFO (SUITE-TestUtilizeNode-seed#[BC09242B5A69A8B7]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 724026 WARN (jetty-launcher-1921-thread-1) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 724026 WARN (jetty-launcher-1921-thread-2) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 724026 WARN (jetty-launcher-1921-thread-3) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 724027 INFO (jetty-launcher-1921-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 724027 INFO (jetty-launcher-1921-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 724027 INFO (jetty-launcher-1921-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 724027 INFO (jetty-launcher-1921-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 724027 INFO (jetty-launcher-1921-thread-1) [ ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 11.0.4+10-LTS
[junit4] 2> 724027 INFO (jetty-launcher-1921-thread-2) [ ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 11.0.4+10-LTS
[junit4] 2> 724035 INFO (jetty-launcher-1921-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 724035 INFO (jetty-launcher-1921-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 724035 INFO (jetty-launcher-1921-thread-3) [ ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 11.0.4+10-LTS
[junit4] 2> 724037 INFO (jetty-launcher-1921-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 724037 INFO (jetty-launcher-1921-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 724037 INFO (jetty-launcher-1921-thread-3) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 724037 INFO (jetty-launcher-1921-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 724037 INFO (jetty-launcher-1921-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 724037 INFO (jetty-launcher-1921-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 724037 INFO (jetty-launcher-1921-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@47b22f1e{/solr,null,AVAILABLE}
[junit4] 2> 724037 INFO (jetty-launcher-1921-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@40154f18{/solr,null,AVAILABLE}
[junit4] 2> 724039 INFO (jetty-launcher-1921-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@54c73f2b{ssl,[ssl, alpn, http/1.1, h2]}{127.0.0.1:36280}
[junit4] 2> 724039 INFO (jetty-launcher-1921-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@2b71f5c1{ssl,[ssl, alpn, http/1.1, h2]}{127.0.0.1:34261}
[junit4] 2> 724039 INFO (jetty-launcher-1921-thread-3) [ ] o.e.j.s.Server Started @724214ms
[junit4] 2> 724039 INFO (jetty-launcher-1921-thread-1) [ ] o.e.j.s.Server Started @724214ms
[junit4] 2> 724039 INFO (jetty-launcher-1921-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=36280}
[junit4] 2> 724039 INFO (jetty-launcher-1921-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=34261}
[junit4] 2> 724040 ERROR (jetty-launcher-1921-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 724040 INFO (jetty-launcher-1921-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 724040 ERROR (jetty-launcher-1921-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 724040 INFO (jetty-launcher-1921-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 724052 INFO (jetty-launcher-1921-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0
[junit4] 2> 724052 INFO (jetty-launcher-1921-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0
[junit4] 2> 724052 INFO (jetty-launcher-1921-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 724052 INFO (jetty-launcher-1921-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 724052 INFO (jetty-launcher-1921-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 724052 INFO (jetty-launcher-1921-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 724052 INFO (jetty-launcher-1921-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-09-30T00:36:31.620283Z
[junit4] 2> 724052 INFO (jetty-launcher-1921-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-09-30T00:36:31.620281Z
[junit4] 2> 724053 INFO (jetty-launcher-1921-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 724053 INFO (jetty-launcher-1921-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 724053 INFO (jetty-launcher-1921-thread-2) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 724053 INFO (jetty-launcher-1921-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 724053 INFO (jetty-launcher-1921-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 724053 INFO (jetty-launcher-1921-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@33f1a56a{/solr,null,AVAILABLE}
[junit4] 2> 724054 INFO (jetty-launcher-1921-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@cfbe048{ssl,[ssl, alpn, http/1.1, h2]}{127.0.0.1:40593}
[junit4] 2> 724054 INFO (jetty-launcher-1921-thread-2) [ ] o.e.j.s.Server Started @724229ms
[junit4] 2> 724054 INFO (jetty-launcher-1921-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=40593}
[junit4] 2> 724055 ERROR (jetty-launcher-1921-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 724055 INFO (jetty-launcher-1921-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 724055 INFO (jetty-launcher-1921-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0
[junit4] 2> 724055 INFO (jetty-launcher-1921-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 724055 INFO (jetty-launcher-1921-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 724055 INFO (jetty-launcher-1921-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-09-30T00:36:31.623286Z
[junit4] 2> 724065 INFO (jetty-launcher-1921-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 724065 INFO (zkConnectionManagerCallback-1925-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 724065 INFO (jetty-launcher-1921-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 724065 INFO (zkConnectionManagerCallback-1924-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 724065 INFO (jetty-launcher-1921-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 724066 INFO (zkConnectionManagerCallback-1927-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 724066 INFO (jetty-launcher-1921-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 724066 INFO (jetty-launcher-1921-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 724066 INFO (jetty-launcher-1921-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 724066 INFO (jetty-launcher-1921-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 724635 INFO (jetty-launcher-1921-thread-3) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 724651 WARN (jetty-launcher-1921-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@6cea97ad[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 724651 WARN (jetty-launcher-1921-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@6cea97ad[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 724672 WARN (jetty-launcher-1921-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@23a82971[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 724672 WARN (jetty-launcher-1921-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@23a82971[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 724673 INFO (jetty-launcher-1921-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33929/solr
[junit4] 2> 724690 INFO (jetty-launcher-1921-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 724708 INFO (zkConnectionManagerCallback-1936-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 724708 INFO (jetty-launcher-1921-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 724779 INFO (jetty-launcher-1921-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 724781 INFO (jetty-launcher-1921-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 724799 WARN (jetty-launcher-1921-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@a530a76[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 724799 WARN (jetty-launcher-1921-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@a530a76[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 724800 WARN (jetty-launcher-1921-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@5e60c607[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 724800 WARN (jetty-launcher-1921-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@5e60c607[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 724836 WARN (jetty-launcher-1921-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@2072509c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 724836 WARN (jetty-launcher-1921-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@2072509c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 724870 INFO (jetty-launcher-1921-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33929/solr
[junit4] 2> 724906 INFO (jetty-launcher-1921-thread-3) [n:127.0.0.1:36280_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 724918 INFO (zkConnectionManagerCallback-1945-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 724918 INFO (jetty-launcher-1921-thread-3) [n:127.0.0.1:36280_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 724919 INFO (jetty-launcher-1921-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 724921 WARN (jetty-launcher-1921-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@7ccb927[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 724921 WARN (jetty-launcher-1921-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@7ccb927[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 724922 INFO (jetty-launcher-1921-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33929/solr
[junit4] 2> 724945 INFO (jetty-launcher-1921-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 724945 INFO (zkConnectionManagerCallback-1947-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 724951 INFO (jetty-launcher-1921-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 724963 INFO (zkConnectionManagerCallback-1952-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 724963 INFO (jetty-launcher-1921-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 725117 INFO (jetty-launcher-1921-thread-2) [n:127.0.0.1:40593_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 725202 INFO (zkConnectionManagerCallback-1954-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 725202 INFO (jetty-launcher-1921-thread-2) [n:127.0.0.1:40593_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 725226 INFO (jetty-launcher-1921-thread-1) [n:127.0.0.1:34261_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 725243 INFO (zkConnectionManagerCallback-1956-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 725243 INFO (jetty-launcher-1921-thread-1) [n:127.0.0.1:34261_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 725257 INFO (jetty-launcher-1921-thread-2) [n:127.0.0.1:40593_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:40593_solr
[junit4] 2> 725257 INFO (jetty-launcher-1921-thread-2) [n:127.0.0.1:40593_solr ] o.a.s.c.Overseer Overseer (id=75474719216041994-127.0.0.1:40593_solr-n_0000000000) starting
[junit4] 2> 725387 INFO (jetty-launcher-1921-thread-1) [n:127.0.0.1:34261_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:34261_solr
[junit4] 2> 725421 INFO (jetty-launcher-1921-thread-2) [n:127.0.0.1:40593_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 725442 INFO (zkConnectionManagerCallback-1965-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 725442 INFO (jetty-launcher-1921-thread-2) [n:127.0.0.1:40593_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 725443 INFO (jetty-launcher-1921-thread-1) [n:127.0.0.1:34261_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 725468 INFO (zkCallback-1953-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 725502 INFO (zkConnectionManagerCallback-1970-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 725502 INFO (jetty-launcher-1921-thread-1) [n:127.0.0.1:34261_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 725510 INFO (zkCallback-1955-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 725538 INFO (jetty-launcher-1921-thread-2) [n:127.0.0.1:40593_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 725539 INFO (jetty-launcher-1921-thread-1) [n:127.0.0.1:34261_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 725541 INFO (jetty-launcher-1921-thread-2) [n:127.0.0.1:40593_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33929/solr ready
[junit4] 2> 725542 INFO (jetty-launcher-1921-thread-1) [n:127.0.0.1:34261_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33929/solr ready
[junit4] 2> 725542 INFO (jetty-launcher-1921-thread-1) [n:127.0.0.1:34261_solr ] o.a.s.c.PackageManager clusterprops.json changed , version 0
[junit4] 2> 725612 INFO (jetty-launcher-1921-thread-2) [n:127.0.0.1:40593_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:40593_solr as DOWN
[junit4] 2> 725619 INFO (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:40593_solr
[junit4] 2> 725656 DEBUG (OverseerAutoScalingTriggerThread-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and .scheduled_maintenance triggers
[junit4] 2> 725758 INFO (jetty-launcher-1921-thread-2) [n:127.0.0.1:40593_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 725758 INFO (jetty-launcher-1921-thread-2) [n:127.0.0.1:40593_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:40593_solr
[junit4] 2> 725759 DEBUG (OverseerAutoScalingTriggerThread-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1
[junit4] 2> 725759 DEBUG (OverseerAutoScalingTriggerThread-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 0
[junit4] 2> 725759 DEBUG (OverseerAutoScalingTriggerThread-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
[junit4] 2> 725796 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"downnode",
[junit4] 2> "node_name":"127.0.0.1:40593_solr"} current state version: 0
[junit4] 2> 725796 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 127.0.0.1:40593_solr
[junit4] 2> 725797 INFO (jetty-launcher-1921-thread-2) [n:127.0.0.1:40593_solr ] o.a.s.c.PackageManager clusterprops.json changed , version 0
[junit4] 2> 725810 INFO (zkCallback-1953-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 725810 INFO (zkCallback-1955-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 725927 INFO (zkCallback-1969-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 725940 DEBUG (OverseerAutoScalingTriggerThread-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial livenodes: [127.0.0.1:34261_solr]
[junit4] 2> 725978 INFO (zkCallback-1964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 725978 INFO (jetty-launcher-1921-thread-1) [n:127.0.0.1:34261_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 725978 INFO (jetty-launcher-1921-thread-2) [n:127.0.0.1:40593_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 725983 DEBUG (OverseerAutoScalingTriggerThread-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread -- cleaning old nodeLost / nodeAdded markers
[junit4] 2> 725983 DEBUG (ScheduledTrigger-1942-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 1
[junit4] 2> 725984 DEBUG (OverseerAutoScalingTriggerThread-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
[junit4] 2> 726131 INFO (jetty-launcher-1921-thread-1) [n:127.0.0.1:34261_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34261.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ee85fbf
[junit4] 2> 726152 INFO (jetty-launcher-1921-thread-2) [n:127.0.0.1:40593_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_40593.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ee85fbf
[junit4] 2> 726224 INFO (jetty-launcher-1921-thread-2) [n:127.0.0.1:40593_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_40593.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ee85fbf
[junit4] 2> 726224 INFO (jetty-launcher-1921-thread-2) [n:127.0.0.1:40593_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_40593.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ee85fbf
[junit4] 2> 726226 INFO (jetty-launcher-1921-thread-2) [n:127.0.0.1:40593_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestUtilizeNode_BC09242B5A69A8B7-001/tempDir-001/node2/.
[junit4] 2> 726242 INFO (jetty-launcher-1921-thread-1) [n:127.0.0.1:34261_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34261.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ee85fbf
[junit4] 2> 726243 INFO (jetty-launcher-1921-thread-1) [n:127.0.0.1:34261_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34261.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ee85fbf
[junit4] 2> 726261 INFO (jetty-launcher-1921-thread-1) [n:127.0.0.1:34261_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestUtilizeNode_BC09242B5A69A8B7-001/tempDir-001/node1/.
[junit4] 2> 726569 INFO (jetty-launcher-1921-thread-3) [n:127.0.0.1:36280_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 726681 INFO (jetty-launcher-1921-thread-3) [n:127.0.0.1:36280_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:36280_solr as DOWN
[junit4] 2> 726718 INFO (jetty-launcher-1921-thread-3) [n:127.0.0.1:36280_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 726718 INFO (jetty-launcher-1921-thread-3) [n:127.0.0.1:36280_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:36280_solr
[junit4] 2> 726771 INFO (zkCallback-1955-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 726771 INFO (zkCallback-1964-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 726771 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"downnode",
[junit4] 2> "node_name":"127.0.0.1:36280_solr"} current state version: 0
[junit4] 2> 726771 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 127.0.0.1:36280_solr
[junit4] 2> 726771 INFO (zkCallback-1969-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 726791 INFO (zkCallback-1953-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 726803 INFO (zkCallback-1944-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 726820 INFO (jetty-launcher-1921-thread-3) [n:127.0.0.1:36280_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 726900 INFO (zkConnectionManagerCallback-1977-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 726900 INFO (jetty-launcher-1921-thread-3) [n:127.0.0.1:36280_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 726977 INFO (jetty-launcher-1921-thread-3) [n:127.0.0.1:36280_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 727010 INFO (jetty-launcher-1921-thread-3) [n:127.0.0.1:36280_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33929/solr ready
[junit4] 2> 727010 INFO (jetty-launcher-1921-thread-3) [n:127.0.0.1:36280_solr ] o.a.s.c.PackageManager clusterprops.json changed , version 0
[junit4] 2> 727273 DEBUG (ScheduledTrigger-1942-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 3 and last live nodes: 2
[junit4] 2> 727537 INFO (jetty-launcher-1921-thread-3) [n:127.0.0.1:36280_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 727618 INFO (jetty-launcher-1921-thread-3) [n:127.0.0.1:36280_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36280.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ee85fbf
[junit4] 2> 727680 INFO (jetty-launcher-1921-thread-3) [n:127.0.0.1:36280_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36280.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ee85fbf
[junit4] 2> 727680 INFO (jetty-launcher-1921-thread-3) [n:127.0.0.1:36280_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36280.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ee85fbf
[junit4] 2> 727681 INFO (jetty-launcher-1921-thread-3) [n:127.0.0.1:36280_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestUtilizeNode_BC09242B5A69A8B7-001/tempDir-001/node3/.
[junit4] 2> 728023 INFO (SUITE-TestUtilizeNode-seed#[BC09242B5A69A8B7]-worker) [ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=3
[junit4] 2> 728042 INFO (SUITE-TestUtilizeNode-seed#[BC09242B5A69A8B7]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 728080 INFO (zkConnectionManagerCallback-1983-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 728095 INFO (SUITE-TestUtilizeNode-seed#[BC09242B5A69A8B7]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 728164 INFO (SUITE-TestUtilizeNode-seed#[BC09242B5A69A8B7]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 728302 INFO (SUITE-TestUtilizeNode-seed#[BC09242B5A69A8B7]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33929/solr ready
[junit4] 2> 728318 DEBUG (ScheduledTrigger-1942-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 3 and last live nodes: 3
[junit4] 2> 728758 INFO (qtp1686834459-6511) [n:127.0.0.1:34261_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :overseerstatus with params action=OVERSEERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 728968 INFO (qtp1686834459-6511) [n:127.0.0.1:34261_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=OVERSEERSTATUS&wt=javabin&version=2} status=0 QTime=209
[junit4] 2> 729266 INFO (TEST-TestUtilizeNode.test-seed#[BC09242B5A69A8B7]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 729318 DEBUG (ScheduledTrigger-1942-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 3 and last live nodes: 3
[junit4] 2> 729336 INFO (TEST-TestUtilizeNode.test-seed#[BC09242B5A69A8B7]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 729339 INFO (TEST-TestUtilizeNode.test-seed#[BC09242B5A69A8B7]) [ ] o.a.s.c.TestUtilizeNode Creating Collection...
[junit4] 2> 729446 INFO (qtp1686834459-6516) [n:127.0.0.1:34261_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=conf1&maxShardsPerNode=2&name=utilizenodecoll&nrtReplicas=2&action=CREATE&numShards=2&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 729593 INFO (OverseerCollectionConfigSetProcessor-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_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> 729611 INFO (OverseerThreadFactory-1944-thread-2-processing-n:127.0.0.1:40593_solr) [n:127.0.0.1:40593_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection utilizenodecoll
[junit4] 2> 729684 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "name":"utilizenodecoll",
[junit4] 2> "fromApi":"true",
[junit4] 2> "collection.configName":"conf1",
[junit4] 2> "numShards":"2",
[junit4] 2> "maxShardsPerNode":"2",
[junit4] 2> "nrtReplicas":"2",
[junit4] 2> "stateFormat":"2",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "operation":"create"} current state version: 0
[junit4] 2> 729685 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.ClusterStateMutator building a new cName: utilizenodecoll
[junit4] 2> 729685 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/utilizenodecoll/state.json
[junit4] 2> 729816 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"utilizenodecoll",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"utilizenodecoll_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:36280/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 729816 INFO (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"utilizenodecoll",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"utilizenodecoll_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:36280/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 729817 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-ffffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{}}
[junit4] 2> 729817 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{
[junit4] 2> "range":"80000000-ffffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node3":{
[junit4] 2> "core":"utilizenodecoll_shard1_replica_n1",
[junit4] 2> "base_url":"https://127.0.0.1:36280/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":null,
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 729868 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.Overseer processMessage: queueSize: 4, message = {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"utilizenodecoll",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"utilizenodecoll_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:40593/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 729868 INFO (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"utilizenodecoll",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"utilizenodecoll_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:40593/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 729869 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-ffffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node3":{
[junit4] 2> "core":"utilizenodecoll_shard1_replica_n1",
[junit4] 2> "base_url":"https://127.0.0.1:36280/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":null,
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 729869 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{
[junit4] 2> "range":"80000000-ffffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2> "core":"utilizenodecoll_shard1_replica_n1",
[junit4] 2> "base_url":"https://127.0.0.1:36280/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":null,
[junit4] 2> "type":"NRT"},
[junit4] 2> "core_node6":{
[junit4] 2> "core":"utilizenodecoll_shard1_replica_n2",
[junit4] 2> "base_url":"https://127.0.0.1:40593/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":null,
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 729869 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.Overseer processMessage: queueSize: 4, message = {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"utilizenodecoll",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"utilizenodecoll_shard2_replica_n4",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:34261/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 729869 INFO (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"utilizenodecoll",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"utilizenodecoll_shard2_replica_n4",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:34261/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 729879 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.SliceMutator Old Slice: shard2:{
[junit4] 2> "range":"0-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{}}
[junit4] 2> 729879 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.SliceMutator New Slice: shard2:{
[junit4] 2> "range":"0-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node7":{
[junit4] 2> "core":"utilizenodecoll_shard2_replica_n4",
[junit4] 2> "base_url":"https://127.0.0.1:34261/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":null,
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 729879 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.Overseer processMessage: queueSize: 4, message = {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"utilizenodecoll",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"utilizenodecoll_shard2_replica_n5",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:36280/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 729879 INFO (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"utilizenodecoll",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"utilizenodecoll_shard2_replica_n5",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:36280/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 729880 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.SliceMutator Old Slice: shard2:{
[junit4] 2> "range":"0-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node7":{
[junit4] 2> "core":"utilizenodecoll_shard2_replica_n4",
[junit4] 2> "base_url":"https://127.0.0.1:34261/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":null,
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 729880 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.SliceMutator New Slice: shard2:{
[junit4] 2> "range":"0-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node7":{
[junit4] 2> "core":"utilizenodecoll_shard2_replica_n4",
[junit4] 2> "base_url":"https://127.0.0.1:34261/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":null,
[junit4] 2> "type":"NRT"},
[junit4] 2> "core_node8":{
[junit4] 2> "core":"utilizenodecoll_shard2_replica_n5",
[junit4] 2> "base_url":"https://127.0.0.1:36280/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":null,
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 729982 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/utilizenodecoll/state.json version: 0
[junit4] 2> 730198 INFO (qtp1686834459-6511) [n:127.0.0.1:34261_solr x:utilizenodecoll_shard2_replica_n4 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf1&newCollection=true&name=utilizenodecoll_shard2_replica_n4&action=CREATE&numShards=2&collection=utilizenodecoll&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 730215 INFO (qtp1686834459-6511) [n:127.0.0.1:34261_solr x:utilizenodecoll_shard2_replica_n4 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 730310 INFO (qtp1124146275-6513) [n:127.0.0.1:40593_solr x:utilizenodecoll_shard1_replica_n2 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node6&collection.configName=conf1&newCollection=true&name=utilizenodecoll_shard1_replica_n2&action=CREATE&numShards=2&collection=utilizenodecoll&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 730324 DEBUG (ScheduledTrigger-1942-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 3 and last live nodes: 3
[junit4] 2> 730344 INFO (qtp457033735-6510) [n:127.0.0.1:36280_solr x:utilizenodecoll_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf1&newCollection=true&name=utilizenodecoll_shard1_replica_n1&action=CREATE&numShards=2&collection=utilizenodecoll&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 730456 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "core":"utilizenodecoll_shard2_replica_n4",
[junit4] 2> "core_node_name":"core_node7",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:34261/solr",
[junit4] 2> "node_name":"127.0.0.1:34261_solr",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"utilizenodecoll",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 730456 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={
[junit4] 2> "core":"utilizenodecoll_shard2_replica_n4",
[junit4] 2> "core_node_name":"core_node7",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:34261/solr",
[junit4] 2> "node_name":"127.0.0.1:34261_solr",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"utilizenodecoll",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"}
[junit4] 2> 730456 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node7:{
[junit4] 2> "core":"utilizenodecoll_shard2_replica_n4",
[junit4] 2> "base_url":"https://127.0.0.1:34261/solr",
[junit4] 2> "node_name":"127.0.0.1:34261_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}
[junit4] 2> 730456 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(utilizenodecoll//collections/utilizenodecoll/state.json/1)={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"2",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"2",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{
[junit4] 2> "shard1":{
[junit4] 2> "range":"80000000-ffffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2> "core":"utilizenodecoll_shard1_replica_n1",
[junit4] 2> "base_url":"https://127.0.0.1:36280/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":null,
[junit4] 2> "type":"NRT"},
[junit4] 2> "core_node6":{
[junit4] 2> "core":"utilizenodecoll_shard1_replica_n2",
[junit4] 2> "base_url":"https://127.0.0.1:40593/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":null,
[junit4] 2> "type":"NRT"}}},
[junit4] 2> "shard2":{
[junit4] 2> "range":"0-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node7":{
[junit4] 2> "core":"utilizenodecoll_shard2_replica_n4",
[junit4] 2> "base_url":"https://127.0.0.1:34261/solr",
[junit4] 2> "node_name":"127.0.0.1:34261_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"},
[junit4] 2> "core_node8":{
[junit4] 2> "core":"utilizenodecoll_shard2_replica_n5",
[junit4] 2> "base_url":"https://127.0.0.1:36280/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":null,
[junit4] 2> "type":"NRT"}}}}}
[junit4] 2> 730470 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
[junit4] 2> "core":"utilizenodecoll_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node3",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:36280/solr",
[junit4] 2> "node_name":"127.0.0.1:36280_solr",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"utilizenodecoll",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 730470 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={
[junit4] 2> "core":"utilizenodecoll_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node3",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:36280/solr",
[junit4] 2> "node_name":"127.0.0.1:36280_solr",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"utilizenodecoll",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"}
[junit4] 2> 730470 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node3:{
[junit4] 2> "core":"utilizenodecoll_shard1_replica_n1",
[junit4] 2> "base_url":"https://127.0.0.1:36280/solr",
[junit4] 2> "node_name":"127.0.0.1:36280_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}
[junit4] 2> 730470 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(utilizenodecoll//collections/utilizenodecoll/state.json/1)={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"2",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"2",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{
[junit4] 2> "shard1":{
[junit4] 2> "range":"80000000-ffffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2> "core":"utilizenodecoll_shard1_replica_n1",
[junit4] 2> "base_url":"https://127.0.0.1:36280/solr",
[junit4] 2> "node_name":"127.0.0.1:36280_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"},
[junit4] 2> "core_node6":{
[junit4] 2> "core":"utilizenodecoll_shard1_replica_n2",
[junit4] 2> "base_url":"https://127.0.0.1:40593/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":null,
[junit4] 2> "type":"NRT"}}},
[junit4] 2> "shard2":{
[junit4] 2> "range":"0-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node7":{
[junit4] 2> "core":"utilizenodecoll_shard2_replica_n4",
[junit4] 2> "base_url":"https://127.0.0.1:34261/solr",
[junit4] 2> "node_name":"127.0.0.1:34261_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"},
[junit4] 2> "core_node8":{
[junit4] 2> "core":"utilizenodecoll_shard2_replica_n5",
[junit4] 2> "base_url":"https://127.0.0.1:36280/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":null,
[junit4] 2> "type":"NRT"}}}}}
[junit4] 2> 730472 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.Overseer processMessage: queueSize: 3, message = {
[junit4] 2> "core":"utilizenodecoll_shard1_replica_n2",
[junit4] 2> "core_node_name":"core_node6",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:40593/solr",
[junit4] 2> "node_name":"127.0.0.1:40593_solr",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"utilizenodecoll",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 730472 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={
[junit4] 2> "core":"utilizenodecoll_shard1_replica_n2",
[junit4] 2> "core_node_name":"core_node6",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:40593/solr",
[junit4] 2> "node_name":"127.0.0.1:40593_solr",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"utilizenodecoll",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"}
[junit4] 2> 730472 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node6:{
[junit4] 2> "core":"utilizenodecoll_shard1_replica_n2",
[junit4] 2> "base_url":"https://127.0.0.1:40593/solr",
[junit4] 2> "node_name":"127.0.0.1:40593_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}
[junit4] 2> 730472 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(utilizenodecoll//collections/utilizenodecoll/state.json/1)={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"2",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"2",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{
[junit4] 2> "shard1":{
[junit4] 2> "range":"80000000-ffffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2> "core":"utilizenodecoll_shard1_replica_n1",
[junit4] 2> "base_url":"https://127.0.0.1:36280/solr",
[junit4] 2> "node_name":"127.0.0.1:36280_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"},
[junit4] 2> "core_node6":{
[junit4] 2> "core":"utilizenodecoll_shard1_replica_n2",
[junit4] 2> "base_url":"https://127.0.0.1:40593/solr",
[junit4] 2> "node_name":"127.0.0.1:40593_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}}},
[junit4] 2> "shard2":{
[junit4] 2> "range":"0-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node7":{
[junit4] 2> "core":"utilizenodecoll_shard2_replica_n4",
[junit4] 2> "base_url":"https://127.0.0.1:34261/solr",
[junit4] 2> "node_name":"127.0.0.1:34261_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"},
[junit4] 2> "core_node8":{
[junit4] 2> "core":"utilizenodecoll_shard2_replica_n5",
[junit4] 2> "base_url":"https://127.0.0.1:36280/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":null,
[junit4] 2> "type":"NRT"}}}}}
[junit4] 2> 730559 INFO (qtp457033735-6508) [n:127.0.0.1:36280_solr x:utilizenodecoll_shard2_replica_n5 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf1&newCollection=true&name=utilizenodecoll_shard2_replica_n5&action=CREATE&numShards=2&collection=utilizenodecoll&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 730566 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.Overseer processMessage: queueSize: 4, message = {
[junit4] 2> "core":"utilizenodecoll_shard2_replica_n5",
[junit4] 2> "core_node_name":"core_node8",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:36280/solr",
[junit4] 2> "node_name":"127.0.0.1:36280_solr",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"utilizenodecoll",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 730566 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={
[junit4] 2> "core":"utilizenodecoll_shard2_replica_n5",
[junit4] 2> "core_node_name":"core_node8",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:36280/solr",
[junit4] 2> "node_name":"127.0.0.1:36280_solr",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"utilizenodecoll",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"}
[junit4] 2> 730566 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node8:{
[junit4] 2> "core":"utilizenodecoll_shard2_replica_n5",
[junit4] 2> "base_url":"https://127.0.0.1:36280/solr",
[junit4] 2> "node_name":"127.0.0.1:36280_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}
[junit4] 2> 730566 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(utilizenodecoll//collections/utilizenodecoll/state.json/1)={
[junit4] 2> "pullReplicas":"0",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "router":{"name":"compositeId"},
[junit4] 2> "maxShardsPerNode":"2",
[junit4] 2> "autoAddReplicas":"false",
[junit4] 2> "nrtReplicas":"2",
[junit4] 2> "tlogReplicas":"0",
[junit4] 2> "shards":{
[junit4] 2> "shard1":{
[junit4] 2> "range":"80000000-ffffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2> "core":"utilizenodecoll_shard1_replica_n1",
[junit4] 2> "base_url":"https://127.0.0.1:36280/solr",
[junit4] 2> "node_name":"127.0.0.1:36280_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"},
[junit4] 2> "core_node6":{
[junit4] 2> "core":"utilizenodecoll_shard1_replica_n2",
[junit4] 2> "base_url":"https://127.0.0.1:40593/solr",
[junit4] 2> "node_name":"127.0.0.1:40593_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}}},
[junit4] 2> "shard2":{
[junit4] 2> "range":"0-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node7":{
[junit4] 2> "core":"utilizenodecoll_shard2_replica_n4",
[junit4] 2> "base_url":"https://127.0.0.1:34261/solr",
[junit4] 2> "node_name":"127.0.0.1:34261_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"},
[junit4] 2> "core_node8":{
[junit4] 2> "core":"utilizenodecoll_shard2_replica_n5",
[junit4] 2> "base_url":"https://127.0.0.1:36280/solr",
[junit4] 2> "node_name":"127.0.0.1:36280_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}}}}}
[junit4] 2> 730674 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/utilizenodecoll/state.json version: 1
[junit4] 2> 731336 DEBUG (ScheduledTrigger-1942-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 3 and last live nodes: 3
[junit4] 2> 731534 INFO (qtp1686834459-6511) [n:127.0.0.1:34261_solr c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 731552 INFO (qtp457033735-6510) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 731590 INFO (qtp1124146275-6513) [n:127.0.0.1:40593_solr c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 731642 INFO (qtp457033735-6508) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 731681 INFO (qtp1686834459-6511) [n:127.0.0.1:34261_solr c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4 ] o.a.s.s.IndexSchema [utilizenodecoll_shard2_replica_n4] Schema name=cloud-dynamic
[junit4] 2> 731715 INFO (qtp457033735-6510) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1 ] o.a.s.s.IndexSchema [utilizenodecoll_shard1_replica_n1] Schema name=cloud-dynamic
[junit4] 2> 732069 INFO (qtp457033735-6508) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5 ] o.a.s.s.IndexSchema [utilizenodecoll_shard2_replica_n5] Schema name=cloud-dynamic
[junit4] 2> 732089 INFO (qtp457033735-6510) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
[junit4] 2> 732089 INFO (qtp457033735-6510) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore 'utilizenodecoll_shard1_replica_n1' using configuration from collection utilizenodecoll, trusted=true
[junit4] 2> 732089 INFO (qtp1124146275-6513) [n:127.0.0.1:40593_solr c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2 ] o.a.s.s.IndexSchema [utilizenodecoll_shard1_replica_n2] Schema name=cloud-dynamic
[junit4] 2> 732089 INFO (qtp457033735-6510) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36280.solr.core.utilizenodecoll.shard1.replica_n1' (registry 'solr.core.utilizenodecoll.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ee85fbf
[junit4] 2> 732090 INFO (qtp457033735-6510) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1 ] o.a.s.c.SolrCore [[utilizenodecoll_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestUtilizeNode_BC09242B5A69A8B7-001/tempDir-001/node3/utilizenodecoll_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestUtilizeNode_BC09242B5A69A8B7-001/tempDir-001/node3/./utilizenodecoll_shard1_replica_n1/data/]
[junit4] 2> 732106 INFO (qtp1686834459-6511) [n:127.0.0.1:34261_solr c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4 ] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
[junit4] 2> 732106 INFO (qtp1686834459-6511) [n:127.0.0.1:34261_solr c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4 ] o.a.s.c.CoreContainer Creating SolrCore 'utilizenodecoll_shard2_replica_n4' using configuration from collection utilizenodecoll, trusted=true
[junit4] 2> 732106 INFO (qtp1686834459-6511) [n:127.0.0.1:34261_solr c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34261.solr.core.utilizenodecoll.shard2.replica_n4' (registry 'solr.core.utilizenodecoll.shard2.replica_n4') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ee85fbf
[junit4] 2> 732106 INFO (qtp1686834459-6511) [n:127.0.0.1:34261_solr c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4 ] o.a.s.c.SolrCore [[utilizenodecoll_shard2_replica_n4] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestUtilizeNode_BC09242B5A69A8B7-001/tempDir-001/node1/utilizenodecoll_shard2_replica_n4], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestUtilizeNode_BC09242B5A69A8B7-001/tempDir-001/node1/./utilizenodecoll_shard2_replica_n4/data/]
[junit4] 2> 732525 DEBUG (ScheduledTrigger-1942-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 3 and last live nodes: 3
[junit4] 2> 732551 INFO (qtp1124146275-6513) [n:127.0.0.1:40593_solr c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2 ] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
[junit4] 2> 732551 INFO (qtp1124146275-6513) [n:127.0.0.1:40593_solr c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2 ] o.a.s.c.CoreContainer Creating SolrCore 'utilizenodecoll_shard1_replica_n2' using configuration from collection utilizenodecoll, trusted=true
[junit4] 2> 732552 INFO (qtp1124146275-6513) [n:127.0.0.1:40593_solr c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_40593.solr.core.utilizenodecoll.shard1.replica_n2' (registry 'solr.core.utilizenodecoll.shard1.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ee85fbf
[junit4] 2> 732552 INFO (qtp1124146275-6513) [n:127.0.0.1:40593_solr c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2 ] o.a.s.c.SolrCore [[utilizenodecoll_shard1_replica_n2] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestUtilizeNode_BC09242B5A69A8B7-001/tempDir-001/node2/utilizenodecoll_shard1_replica_n2], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestUtilizeNode_BC09242B5A69A8B7-001/tempDir-001/node2/./utilizenodecoll_shard1_replica_n2/data/]
[junit4] 2> 732571 INFO (qtp457033735-6508) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5 ] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
[junit4] 2> 732571 INFO (qtp457033735-6508) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5 ] o.a.s.c.CoreContainer Creating SolrCore 'utilizenodecoll_shard2_replica_n5' using configuration from collection utilizenodecoll, trusted=true
[junit4] 2> 732571 INFO (qtp457033735-6508) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36280.solr.core.utilizenodecoll.shard2.replica_n5' (registry 'solr.core.utilizenodecoll.shard2.replica_n5') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ee85fbf
[junit4] 2> 732572 INFO (qtp457033735-6508) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5 ] o.a.s.c.SolrCore [[utilizenodecoll_shard2_replica_n5] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestUtilizeNode_BC09242B5A69A8B7-001/tempDir-001/node3/utilizenodecoll_shard2_replica_n5], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestUtilizeNode_BC09242B5A69A8B7-001/tempDir-001/node3/./utilizenodecoll_shard2_replica_n5/data/]
[junit4] 2> 733080 INFO (qtp1686834459-6511) [n:127.0.0.1:34261_solr c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 733080 INFO (qtp1686834459-6511) [n:127.0.0.1:34261_solr c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 733134 INFO (qtp1686834459-6511) [n:127.0.0.1:34261_solr c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 733134 INFO (qtp1686834459-6511) [n:127.0.0.1:34261_solr c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 733136 INFO (qtp1686834459-6511) [n:127.0.0.1:34261_solr c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5b480338[utilizenodecoll_shard2_replica_n4] main]
[junit4] 2> 733145 INFO (qtp457033735-6510) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 733145 INFO (qtp457033735-6510) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 733146 INFO (qtp457033735-6510) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 733146 INFO (qtp457033735-6510) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 733148 INFO (qtp457033735-6510) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@3c516845[utilizenodecoll_shard1_replica_n1] main]
[junit4] 2> 733186 INFO (qtp1686834459-6511) [n:127.0.0.1:34261_solr c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 733186 INFO (qtp1686834459-6511) [n:127.0.0.1:34261_solr c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 733187 INFO (qtp1686834459-6511) [n:127.0.0.1:34261_solr c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 733187 INFO (qtp1686834459-6511) [n:127.0.0.1:34261_solr c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1646058590180474880
[junit4] 2> 733203 INFO (searcherExecutor-1958-thread-1-processing-n:127.0.0.1:34261_solr x:utilizenodecoll_shard2_replica_n4 c:utilizenodecoll s:shard2 r:core_node7) [n:127.0.0.1:34261_solr c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4 ] o.a.s.c.SolrCore [utilizenodecoll_shard2_replica_n4] Registered new searcher Searcher@5b480338[utilizenodecoll_shard2_replica_n4] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 733238 INFO (qtp1686834459-6511) [n:127.0.0.1:34261_solr c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/utilizenodecoll/terms/shard2 to Terms{values={core_node7=0}, version=0}
[junit4] 2> 733239 INFO (qtp1686834459-6511) [n:127.0.0.1:34261_solr c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/utilizenodecoll/leaders/shard2
[junit4] 2> 733258 INFO (qtp457033735-6510) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 733259 INFO (qtp457033735-6510) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 733260 INFO (qtp457033735-6510) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 733260 INFO (qtp457033735-6510) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1646058590257020928
[junit4] 2> 733275 INFO (searcherExecutor-1957-thread-1-processing-n:127.0.0.1:36280_solr x:utilizenodecoll_shard1_replica_n1 c:utilizenodecoll s:shard1 r:core_node3) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1 ] o.a.s.c.SolrCore [utilizenodecoll_shard1_replica_n1] Registered new searcher Searcher@3c516845[utilizenodecoll_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 733298 INFO (qtp457033735-6510) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/utilizenodecoll/terms/shard1 to Terms{values={core_node3=0}, version=0}
[junit4] 2> 733312 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"utilizenodecoll"} current state version: 0
[junit4] 2> 733312 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/utilizenodecoll/state.json version: 2
[junit4] 2> 733314 INFO (qtp1686834459-6511) [n:127.0.0.1:34261_solr c:utilizenodecoll s:shard2 r:core_node7 x:utilizenodecoll_shard2_replica_n4 ] o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for shard shard2: total=2 found=1 timeoutin=9999ms
[junit4] 2> 733314 INFO (qtp457033735-6510) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/utilizenodecoll/leaders/shard1
[junit4] 2> 733350 INFO (qtp457033735-6510) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard1 r:core_node3 x:utilizenodecoll_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for shard shard1: total=2 found=1 timeoutin=9999ms
[junit4] 2> 733351 DEBUG (OverseerStateUpdate-75474719216041994-127.0.0.1:40593_solr-n_0000000000) [n:127.0.0.1:40593_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"utilizenodecoll"} current state version: 0
[junit4] 2> 733384 INFO (qtp1124146275-6513) [n:127.0.0.1:40593_solr c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 733384 INFO (qtp1124146275-6513) [n:127.0.0.1:40593_solr c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 733385 INFO (qtp1124146275-6513) [n:127.0.0.1:40593_solr c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 733385 INFO (qtp1124146275-6513) [n:127.0.0.1:40593_solr c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 733400 INFO (qtp457033735-6508) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 733400 INFO (qtp457033735-6508) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 733402 INFO (qtp457033735-6508) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 733402 INFO (qtp457033735-6508) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 733403 INFO (qtp457033735-6508) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5d7b6cc5[utilizenodecoll_shard2_replica_n5] main]
[junit4] 2> 733421 INFO (qtp1124146275-6513) [n:127.0.0.1:40593_solr c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@e38c2a1[utilizenodecoll_shard1_replica_n2] main]
[junit4] 2> 733422 INFO (qtp1124146275-6513) [n:127.0.0.1:40593_solr c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 733423 INFO (qtp1124146275-6513) [n:127.0.0.1:40593_solr c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 733423 INFO (qtp1124146275-6513) [n:127.0.0.1:40593_solr c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 733424 INFO (qtp1124146275-6513) [n:127.0.0.1:40593_solr c:utilizenodecoll s:shard1 r:core_node6 x:utilizenodecoll_shard1_replica_n2 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1646058590428987392
[junit4] 2> 733441 INFO (qtp457033735-6508) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 733441 INFO (qtp457033735-6508) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_replica_n5 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 733442 INFO (qtp457033735-6508) [n:127.0.0.1:36280_solr c:utilizenodecoll s:shard2 r:core_node8 x:utilizenodecoll_shard2_repli
[...truncated too long message...]
90610.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/server/lib/jetty-continuation-9.4.19.v20190610.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/server/lib/jetty-deploy-9.4.19.v20190610.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/server/lib/jetty-http-9.4.19.v20190610.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/server/lib/jetty-io-9.4.19.v20190610.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/server/lib/jetty-jmx-9.4.19.v20190610.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/server/lib/jetty-rewrite-9.4.19.v20190610.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/server/lib/jetty-security-9.4.19.v20190610.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/server/lib/jetty-server-9.4.19.v20190610.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/server/lib/jetty-servlet-9.4.19.v20190610.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/server/lib/jetty-servlets-9.4.19.v20190610.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/server/lib/jetty-util-9.4.19.v20190610.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/server/lib/jetty-webapp-9.4.19.v20190610.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/server/lib/jetty-xml-9.4.19.v20190610.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/server/lib/metrics-core-4.0.5.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/server/lib/metrics-graphite-4.0.5.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/server/lib/metrics-jetty9-4.0.5.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/server/lib/metrics-jmx-4.0.5.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/server/lib/metrics-jvm-4.0.5.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/example/example-DIH/solr/db/lib/derby-10.9.1.0.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/example/example-DIH/solr/db/lib/hsqldb-2.4.0.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/java:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/test-framework/lib/hamcrest-core-1.3.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/test-framework/lib/junit-4.12.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/test-framework/lib/randomizedtesting-runner-2.7.2.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/test-lib/antlr4-runtime-4.5.1-1.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/test-lib/byte-buddy-1.9.3.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/test-lib/commons-logging-1.1.3.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/test-lib/commons-text-1.6.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/test-lib/hadoop-common-3.2.0-tests.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/test-lib/hadoop-hdfs-3.2.0-tests.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/test-lib/hadoop-hdfs-3.2.0.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/test-lib/hadoop-minicluster-3.2.0.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/test-lib/hadoop-minikdc-3.2.0.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/test-lib/jersey-core-1.19.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/test-lib/jersey-server-1.19.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/test-lib/jersey-servlet-1.19.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/test-lib/kerb-admin-1.0.1.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/test-lib/kerb-client-1.0.1.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/test-lib/kerb-common-1.0.1.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/test-lib/kerb-crypto-1.0.1.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/test-lib/kerb-identity-1.0.1.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/test-lib/kerb-server-1.0.1.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/test-lib/kerb-simplekdc-1.0.1.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/test-lib/kerby-config-1.0.1.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/test-lib/kerby-kdc-1.0.1.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/test-lib/kerby-util-1.0.1.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/test-lib/mockito-core-2.23.4.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/test-lib/netty-all-4.0.52.Final.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/test-lib/objenesis-2.6.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/test-lib/opentracing-mock-0.33.0.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/analysis/icu/lucene-analyzers-icu-9.0.0-SNAPSHOT.jar:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/contrib/solr-analysis-extras/classes/java:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/queryparser/classes/test:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/backward-codecs/classes/test:/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/contrib/analysis-extras/lib/icu4j-62.1.jar:/home/jenkins/tools/ant/apache-ant-1.8.4/lib/ant-launcher.jar:/home/jenkins/.ant/lib/ivy-2.4.0.jar:/home/jenkins/tools/ant/apache-ant-1.8.4/lib/ant-apache-oro.jar:/home/jenkins/tools/ant/apache-ant-1.8.4/lib/ant-javamail.jar:/home/jenkins/tools/ant/apache-ant-1.8.4/lib/ant-jsch.jar:/home/jenkins/tools/ant/apache-ant-1.8.4/lib/ant-apache-resolver.jar:/home/jenkins/tools/ant/apache-ant-1.8.4/lib/ant-apache-bsf.jar:/home/jenkins/tools/ant/apache-ant-1.8.4/lib/ant-commons-logging.jar:/home/jenkins/tools/ant/apache-ant-1.8.4/lib/ant-apache-xalan2.jar:/home/jenkins/tools/ant/apache-ant-1.8.4/lib/ant-jdepend.jar:/home/jenkins/tools/ant/apache-ant-1.8.4/lib/ant-junit.jar:/home/jenkins/tools/ant/apache-ant-1.8.4/lib/ant-netrexx.jar:/home/jenkins/tools/ant/apache-ant-1.8.4/lib/ant-commons-net.jar:/home/jenkins/tools/ant/apache-ant-1.8.4/lib/ant-apache-regexp.jar:/home/jenkins/tools/ant/apache-ant-1.8.4/lib/ant-jai.jar:/home/jenkins/tools/ant/apache-ant-1.8.4/lib/ant-junit4.jar:/home/jenkins/tools/ant/apache-ant-1.8.4/lib/ant-testutil.jar:/home/jenkins/tools/ant/apache-ant-1.8.4/lib/ant-jmf.jar:/home/jenkins/tools/ant/apache-ant-1.8.4/lib/ant-antlr.jar:/home/jenkins/tools/ant/apache-ant-1.8.4/lib/ant-swing.jar:/home/jenkins/tools/ant/apache-ant-1.8.4/lib/ant.jar:/home/jenkins/tools/ant/apache-ant-1.8.4/lib/ant-apache-bcel.jar:/home/jenkins/tools/ant/apache-ant-1.8.4/lib/ant-apache-log4j.jar:/home/jenkins/.ivy2/cache/com.carrotsearch.randomizedtesting/junit4-ant/jars/junit4-ant-2.7.2.jar com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe -eventsfile /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/temp/junit4-J2-20190930_002427_28514396420080854060213.events @/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/temp/junit4-J2-20190930_002427_28511061408689344519216.suites -stdin
[junit4] ERROR: JVM J2 ended with an exception: Forked process returned with error code: 137.
[junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4.executeSlave(JUnit4.java:1542)
[junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4.access$000(JUnit4.java:123)
[junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:997)
[junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:994)
[junit4] at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
[junit4] at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
[junit4] at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
[junit4] at java.base/java.lang.Thread.run(Thread.java:834)
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:634: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:578: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:59: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build.xml:232: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/common-build.xml:557: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:1492: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:1019: At least one slave process threw an exception, first: Forked process returned with error code: 137.
Total time: 185 minutes 16 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[Fast Archiver] No artifacts from Lucene-Solr-Tests-master #3801 to compare, so performing full copy of artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any