You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2020/04/14 04:17:19 UTC
[JENKINS] Lucene-Solr-8.5-MacOSX (64bit/jdk-14) - Build # 60 -
Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.5-MacOSX/60/
Java: 64bit/jdk-14 -XX:-UseCompressedOops -XX:+UseG1GC
2 tests failed.
FAILED: org.apache.solr.cloud.SystemCollectionCompatTest.testBackCompat
Error Message:
re-indexing warning not found
Stack Trace:
java.lang.AssertionError: re-indexing warning not found
at __randomizedtesting.SeedInfo.seed([22A3F8A7030506DC:52565B0E63CDAFAA]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.assertTrue(Assert.java:41)
at org.apache.solr.cloud.SystemCollectionCompatTest.testBackCompat(SystemCollectionCompatTest.java:215)
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:564)
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:832)
FAILED: org.apache.solr.cloud.autoscaling.ComputePlanActionTest.testSelectedCollections
Error Message:
Trigger was not fired even after 5 seconds
Stack Trace:
java.lang.AssertionError: Trigger was not fired even after 5 seconds
at __randomizedtesting.SeedInfo.seed([22A3F8A7030506DC:180D1D7E3D61DFB2]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.assertTrue(Assert.java:41)
at org.apache.solr.cloud.autoscaling.ComputePlanActionTest.testSelectedCollections(ComputePlanActionTest.java:507)
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:564)
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:832)
Build Log:
[...truncated 14230 lines...]
[junit4] Suite: org.apache.solr.cloud.autoscaling.ComputePlanActionTest
[junit4] 2> 815245 INFO (SUITE-ComputePlanActionTest-seed#[22A3F8A7030506DC]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/server/solr/configsets/_default/conf'
[junit4] 2> 815247 INFO (SUITE-ComputePlanActionTest-seed#[22A3F8A7030506DC]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.autoscaling.ComputePlanActionTest_22A3F8A7030506DC-001/data-dir-64-001
[junit4] 2> 815247 WARN (SUITE-ComputePlanActionTest-seed#[22A3F8A7030506DC]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
[junit4] 2> 815247 INFO (SUITE-ComputePlanActionTest-seed#[22A3F8A7030506DC]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 815247 INFO (SUITE-ComputePlanActionTest-seed#[22A3F8A7030506DC]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, clientAuth=0.0/0.0) w/ MAC_OS_X supressed clientAuth
[junit4] 2> 815247 INFO (SUITE-ComputePlanActionTest-seed#[22A3F8A7030506DC]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 815248 INFO (SUITE-ComputePlanActionTest-seed#[22A3F8A7030506DC]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.autoscaling.ComputePlanActionTest_22A3F8A7030506DC-001/tempDir-001
[junit4] 2> 815248 INFO (SUITE-ComputePlanActionTest-seed#[22A3F8A7030506DC]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 815249 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 815249 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 815353 INFO (SUITE-ComputePlanActionTest-seed#[22A3F8A7030506DC]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:52699
[junit4] 2> 815353 INFO (SUITE-ComputePlanActionTest-seed#[22A3F8A7030506DC]-worker) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:52699
[junit4] 2> 815353 INFO (SUITE-ComputePlanActionTest-seed#[22A3F8A7030506DC]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:52699
[junit4] 2> 815353 INFO (SUITE-ComputePlanActionTest-seed#[22A3F8A7030506DC]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 52699
[junit4] 2> 815357 INFO (SUITE-ComputePlanActionTest-seed#[22A3F8A7030506DC]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 815363 INFO (zkConnectionManagerCallback-3776-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 815363 INFO (SUITE-ComputePlanActionTest-seed#[22A3F8A7030506DC]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 815369 INFO (SUITE-ComputePlanActionTest-seed#[22A3F8A7030506DC]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 815374 INFO (zkConnectionManagerCallback-3778-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 815375 INFO (SUITE-ComputePlanActionTest-seed#[22A3F8A7030506DC]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 815376 INFO (SUITE-ComputePlanActionTest-seed#[22A3F8A7030506DC]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 815380 INFO (zkConnectionManagerCallback-3780-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 815380 INFO (SUITE-ComputePlanActionTest-seed#[22A3F8A7030506DC]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 815490 WARN (jetty-launcher-3781-thread-1) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 815490 INFO (jetty-launcher-3781-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 815490 INFO (jetty-launcher-3781-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 815490 INFO (jetty-launcher-3781-thread-1) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 14+36
[junit4] 2> 815493 INFO (jetty-launcher-3781-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 815493 INFO (jetty-launcher-3781-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 815493 INFO (jetty-launcher-3781-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 815493 INFO (jetty-launcher-3781-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@69c3f93a{/solr,null,AVAILABLE}
[junit4] 2> 815494 INFO (jetty-launcher-3781-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@59b72286{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:52704}
[junit4] 2> 815494 INFO (jetty-launcher-3781-thread-1) [ ] o.e.j.s.Server Started @815572ms
[junit4] 2> 815494 INFO (jetty-launcher-3781-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=52704}
[junit4] 2> 815494 ERROR (jetty-launcher-3781-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 815494 INFO (jetty-launcher-3781-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 815494 INFO (jetty-launcher-3781-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.5.1
[junit4] 2> 815494 INFO (jetty-launcher-3781-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 815494 INFO (jetty-launcher-3781-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr
[junit4] 2> 815494 INFO (jetty-launcher-3781-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-04-14T03:36:24.970936Z
[junit4] 2> 815496 INFO (jetty-launcher-3781-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 815500 INFO (zkConnectionManagerCallback-3783-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 815500 INFO (jetty-launcher-3781-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 815501 INFO (jetty-launcher-3781-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 815734 INFO (jetty-launcher-3781-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 815735 WARN (jetty-launcher-3781-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@7c8477ab[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 815735 WARN (jetty-launcher-3781-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@7c8477ab[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 815738 WARN (jetty-launcher-3781-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@6c02beb4[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 815738 WARN (jetty-launcher-3781-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@6c02beb4[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 815739 INFO (jetty-launcher-3781-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:52699/solr
[junit4] 2> 815747 INFO (jetty-launcher-3781-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 815749 INFO (zkConnectionManagerCallback-3790-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 815751 INFO (jetty-launcher-3781-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 815868 INFO (jetty-launcher-3781-thread-1) [n:127.0.0.1:52704_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 815871 INFO (zkConnectionManagerCallback-3792-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 815872 INFO (jetty-launcher-3781-thread-1) [n:127.0.0.1:52704_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 816238 INFO (jetty-launcher-3781-thread-1) [n:127.0.0.1:52704_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:52704_solr
[junit4] 2> 816241 INFO (jetty-launcher-3781-thread-1) [n:127.0.0.1:52704_solr ] o.a.s.c.Overseer Overseer (id=72157482958651397-127.0.0.1:52704_solr-n_0000000000) starting
[junit4] 2> 816266 INFO (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:52704_solr
[junit4] 2> 816269 DEBUG (OverseerAutoScalingTriggerThread-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and .scheduled_maintenance triggers
[junit4] 2> 816269 INFO (jetty-launcher-3781-thread-1) [n:127.0.0.1:52704_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:52704_solr
[junit4] 2> 816283 DEBUG (OverseerAutoScalingTriggerThread-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1
[junit4] 2> 816283 DEBUG (OverseerAutoScalingTriggerThread-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 0
[junit4] 2> 816283 DEBUG (OverseerAutoScalingTriggerThread-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
[junit4] 2> 816302 INFO (zkCallback-3791-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 816361 INFO (jetty-launcher-3781-thread-1) [n:127.0.0.1:52704_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 816368 WARN (jetty-launcher-3781-thread-1) [n:127.0.0.1:52704_solr ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 816378 DEBUG (OverseerAutoScalingTriggerThread-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial livenodes: [127.0.0.1:52704_solr]
[junit4] 2> 816383 DEBUG (OverseerAutoScalingTriggerThread-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded markers
[junit4] 2> 816386 DEBUG (ScheduledTrigger-2368-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 and last live nodes: 1
[junit4] 2> 816387 DEBUG (OverseerAutoScalingTriggerThread-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
[junit4] 2> 816412 INFO (jetty-launcher-3781-thread-1) [n:127.0.0.1:52704_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 816443 INFO (jetty-launcher-3781-thread-1) [n:127.0.0.1:52704_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52704.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7abd9fe5
[junit4] 2> 816461 INFO (jetty-launcher-3781-thread-1) [n:127.0.0.1:52704_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52704.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7abd9fe5
[junit4] 2> 816461 INFO (jetty-launcher-3781-thread-1) [n:127.0.0.1:52704_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52704.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7abd9fe5
[junit4] 2> 816462 INFO (jetty-launcher-3781-thread-1) [n:127.0.0.1:52704_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.autoscaling.ComputePlanActionTest_22A3F8A7030506DC-001/tempDir-001/node1/.
[junit4] 2> 816479 INFO (SUITE-ComputePlanActionTest-seed#[22A3F8A7030506DC]-worker) [ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=1
[junit4] 2> 816480 INFO (SUITE-ComputePlanActionTest-seed#[22A3F8A7030506DC]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 816485 INFO (zkConnectionManagerCallback-3801-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 816485 INFO (SUITE-ComputePlanActionTest-seed#[22A3F8A7030506DC]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 816494 INFO (SUITE-ComputePlanActionTest-seed#[22A3F8A7030506DC]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 816499 INFO (SUITE-ComputePlanActionTest-seed#[22A3F8A7030506DC]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:52699/solr ready
[junit4] 2> 816553 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testNodeAdded
[junit4] 2> 816555 DEBUG (zkCallback-3791-thread-1) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 2
[junit4] 2> 816555 DEBUG (OverseerAutoScalingTriggerThread-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2
[junit4] 2> 816561 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 816564 DEBUG (OverseerAutoScalingTriggerThread-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded markers
[junit4] 2> 816571 DEBUG (OverseerAutoScalingTriggerThread-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2
[junit4] 2> 816587 INFO (qtp1467008536-9744) [n:127.0.0.1:52704_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=1
[junit4] 2> 816589 DEBUG (qtp1467008536-9742) [n:127.0.0.1:52704_solr ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 816590 INFO (qtp1467008536-9742) [n:127.0.0.1:52704_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=15
[junit4] 2> 816590 DEBUG (zkCallback-3791-thread-1) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 3
[junit4] 2> 816591 DEBUG (OverseerAutoScalingTriggerThread-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 3
[junit4] 2> 816591 DEBUG (OverseerAutoScalingTriggerThread-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded markers
[junit4] 2> 816592 DEBUG (OverseerAutoScalingTriggerThread-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3, lastZnodeVersion 3
[junit4] 2> 816597 INFO (qtp1467008536-9743) [n:127.0.0.1:52704_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
[junit4] 2> 816597 DEBUG (qtp1467008536-9741) [n:127.0.0.1:52704_solr ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 816599 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=7
[junit4] 2> 816600 DEBUG (zkCallback-3791-thread-1) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 4
[junit4] 2> 816600 DEBUG (OverseerAutoScalingTriggerThread-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 4
[junit4] 2> 816600 DEBUG (OverseerAutoScalingTriggerThread-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded markers
[junit4] 2> 816603 DEBUG (OverseerAutoScalingTriggerThread-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 4, lastZnodeVersion 4
[junit4] 2> 816617 INFO (qtp1467008536-9742) [n:127.0.0.1:52704_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=1
[junit4] 2> 816618 DEBUG (qtp1467008536-9744) [n:127.0.0.1:52704_solr ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 816621 INFO (qtp1467008536-9744) [n:127.0.0.1:52704_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=15
[junit4] 2> 816623 DEBUG (zkCallback-3791-thread-1) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 5
[junit4] 2> 816623 DEBUG (OverseerAutoScalingTriggerThread-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 5
[junit4] 2> 816630 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=0
[junit4] 2> 816631 DEBUG (qtp1467008536-9743) [n:127.0.0.1:52704_solr ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 816634 INFO (qtp1467008536-9743) [n:127.0.0.1:52704_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=11
[junit4] 2> 816636 INFO (qtp1467008536-9742) [n:127.0.0.1:52704_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=conf&maxShardsPerNode=2&name=testNodeAdded&nrtReplicas=2&action=CREATE&numShards=1&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 816637 DEBUG (zkCallback-3791-thread-1) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 6
[junit4] 2> 816644 DEBUG (OverseerAutoScalingTriggerThread-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [ ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger - Initial livenodes: [127.0.0.1:52704_solr]
[junit4] 2> 816644 DEBUG (OverseerAutoScalingTriggerThread-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [ ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger instantiated with properties: {event=nodeAdded, waitFor=1, actions=[{name=compute_plan, class=solr.ComputePlanAction}, {name=test, class=org.apache.solr.cloud.autoscaling.ComputePlanActionTest$AssertingTriggerAction}], enabled=true}
[junit4] 2> 816645 DEBUG (OverseerAutoScalingTriggerThread-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded markers
[junit4] 2> 816649 DEBUG (OverseerAutoScalingTriggerThread-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 6, lastZnodeVersion 5
[junit4] 2> 816649 DEBUG (OverseerAutoScalingTriggerThread-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 6
[junit4] 2> 816650 DEBUG (ScheduledTrigger-2368-thread-2) [ ] o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 816650 DEBUG (ScheduledTrigger-2368-thread-2) [ ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 816652 DEBUG (OverseerAutoScalingTriggerThread-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded markers
[junit4] 2> 816655 DEBUG (OverseerAutoScalingTriggerThread-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 6, lastZnodeVersion 6
[junit4] 2> 816668 INFO (OverseerThreadFactory-2370-thread-1-processing-n:127.0.0.1:52704_solr) [n:127.0.0.1:52704_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection testNodeAdded
[junit4] 2> 816716 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "name":"testNodeAdded",
[junit4] 2> "fromApi":"true",
[junit4] 2> "collection.configName":"conf",
[junit4] 2> "numShards":"1",
[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> 816716 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.o.ClusterStateMutator building a new cName: testNodeAdded
[junit4] 2> 816719 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/testNodeAdded/state.json
[junit4] 2> 816829 WARN (OverseerThreadFactory-2370-thread-1-processing-n:127.0.0.1:52704_solr) [n:127.0.0.1:52704_solr ] o.a.s.c.a.c.CreateCollectionCmd Specified number of replicas of 2 on collection testNodeAdded is higher than the number of Solr instances currently live or live and part of your createNodeSet(1). It's unusual to run two replica of the same slice on the same Solr-instance.
[junit4] 2> 816847 INFO (qtp1467008536-9744) [n:127.0.0.1:52704_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=1
[junit4] 2> 816877 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "node_name":"127.0.0.1:52704_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 816877 INFO (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "node_name":"127.0.0.1:52704_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 816881 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{}}
[junit4] 2> 816881 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node3":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:52704_solr",
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 816888 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "node_name":"127.0.0.1:52704_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"} current state version: 0
[junit4] 2> 816888 INFO (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "node_name":"127.0.0.1:52704_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 816893 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{"core_node3":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:52704_solr",
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 816893 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.o.SliceMutator New Slice: shard1:{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:52704_solr",
[junit4] 2> "type":"NRT"},
[junit4] 2> "core_node4":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:52704_solr",
[junit4] 2> "type":"NRT"}}}
[junit4] 2> 816996 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/testNodeAdded/state.json version: 0
[junit4] 2> 817109 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr x:testNodeAdded_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=testNodeAdded_shard1_replica_n1&action=CREATE&numShards=1&collection=testNodeAdded&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 817110 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr x:testNodeAdded_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 817111 INFO (qtp1467008536-9744) [n:127.0.0.1:52704_solr x:testNodeAdded_shard1_replica_n2 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=testNodeAdded_shard1_replica_n2&action=CREATE&numShards=1&collection=testNodeAdded&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 817131 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node3",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "node_name":"127.0.0.1:52704_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 817131 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node3",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "node_name":"127.0.0.1:52704_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"}
[junit4] 2> 817131 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node3:{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "node_name":"127.0.0.1:52704_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}
[junit4] 2> 817131 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(testNodeAdded//collections/testNodeAdded/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":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "node_name":"127.0.0.1:52704_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"},
[junit4] 2> "core_node4":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "state":"down",
[junit4] 2> "node_name":"127.0.0.1:52704_solr",
[junit4] 2> "type":"NRT"}}}}}
[junit4] 2> 817145 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "core_node_name":"core_node4",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "node_name":"127.0.0.1:52704_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 817145 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "core_node_name":"core_node4",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "node_name":"127.0.0.1:52704_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"}
[junit4] 2> 817145 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node4:{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "node_name":"127.0.0.1:52704_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}
[junit4] 2> 817145 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(testNodeAdded//collections/testNodeAdded/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":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "node_name":"127.0.0.1:52704_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"},
[junit4] 2> "core_node4":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "node_name":"127.0.0.1:52704_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}}}}}
[junit4] 2> 817170 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.5.1
[junit4] 2> 817172 INFO (qtp1467008536-9744) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.5.1
[junit4] 2> 817198 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.s.IndexSchema [testNodeAdded_shard1_replica_n1] Schema name=minimal
[junit4] 2> 817201 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 817201 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore 'testNodeAdded_shard1_replica_n1' using configuration from configset conf, trusted=true
[junit4] 2> 817201 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52704.solr.core.testNodeAdded.shard1.replica_n1' (registry 'solr.core.testNodeAdded.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7abd9fe5
[junit4] 2> 817202 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.c.SolrCore [[testNodeAdded_shard1_replica_n1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.autoscaling.ComputePlanActionTest_22A3F8A7030506DC-001/tempDir-001/node1/testNodeAdded_shard1_replica_n1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.autoscaling.ComputePlanActionTest_22A3F8A7030506DC-001/tempDir-001/node1/./testNodeAdded_shard1_replica_n1/data/]
[junit4] 2> 817203 INFO (qtp1467008536-9744) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ] o.a.s.s.IndexSchema [testNodeAdded_shard1_replica_n2] Schema name=minimal
[junit4] 2> 817205 INFO (qtp1467008536-9744) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 817205 INFO (qtp1467008536-9744) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ] o.a.s.c.CoreContainer Creating SolrCore 'testNodeAdded_shard1_replica_n2' using configuration from configset conf, trusted=true
[junit4] 2> 817205 INFO (qtp1467008536-9744) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52704.solr.core.testNodeAdded.shard1.replica_n2' (registry 'solr.core.testNodeAdded.shard1.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7abd9fe5
[junit4] 2> 817206 INFO (qtp1467008536-9744) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ] o.a.s.c.SolrCore [[testNodeAdded_shard1_replica_n2] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.autoscaling.ComputePlanActionTest_22A3F8A7030506DC-001/tempDir-001/node1/testNodeAdded_shard1_replica_n2], dataDir=[/Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.autoscaling.ComputePlanActionTest_22A3F8A7030506DC-001/tempDir-001/node1/./testNodeAdded_shard1_replica_n2/data/]
[junit4] 2> 817248 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/testNodeAdded/state.json version: 1
[junit4] 2> 817317 INFO (qtp1467008536-9744) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 817317 INFO (qtp1467008536-9744) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 817348 INFO (qtp1467008536-9744) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 817355 INFO (qtp1467008536-9744) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 817362 INFO (qtp1467008536-9744) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@4b7fa283[testNodeAdded_shard1_replica_n2] main]
[junit4] 2> 817367 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 817367 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 817371 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 817372 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 817385 INFO (qtp1467008536-9744) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 817392 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@2ee0f3f5[testNodeAdded_shard1_replica_n1] main]
[junit4] 2> 817392 INFO (qtp1467008536-9744) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 817393 INFO (qtp1467008536-9744) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 817393 INFO (qtp1467008536-9744) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1663917502621548544
[junit4] 2> 817412 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 817441 INFO (searcherExecutor-2376-thread-1-processing-n:127.0.0.1:52704_solr x:testNodeAdded_shard1_replica_n2 c:testNodeAdded s:shard1 r:core_node4) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ] o.a.s.c.SolrCore [testNodeAdded_shard1_replica_n2] Registered new searcher Searcher@4b7fa283[testNodeAdded_shard1_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 817445 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 817445 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 817445 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1663917502676074496
[junit4] 2> 817449 INFO (searcherExecutor-2375-thread-1-processing-n:127.0.0.1:52704_solr x:testNodeAdded_shard1_replica_n1 c:testNodeAdded s:shard1 r:core_node3) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.c.SolrCore [testNodeAdded_shard1_replica_n1] Registered new searcher Searcher@2ee0f3f5[testNodeAdded_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 817490 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/testNodeAdded/terms/shard1 to Terms{values={core_node3=0}, version=0}
[junit4] 2> 817492 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/testNodeAdded/leaders/shard1
[junit4] 2> 817494 INFO (qtp1467008536-9744) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/testNodeAdded/terms/shard1 to Terms{values={core_node3=0, core_node4=0}, version=1}
[junit4] 2> 817496 INFO (qtp1467008536-9744) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/testNodeAdded/leaders/shard1
[junit4] 2> 817537 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testNodeAdded"} current state version: 0
[junit4] 2> 817537 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 817537 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 817537 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:52704/solr/testNodeAdded_shard1_replica_n1/
[junit4] 2> 817542 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.u.PeerSync PeerSync: core=testNodeAdded_shard1_replica_n1 url=http://127.0.0.1:52704/solr START replicas=[http://127.0.0.1:52704/solr/testNodeAdded_shard1_replica_n2/] nUpdates=100
[junit4] 2> 817543 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.u.PeerSync PeerSync: core=testNodeAdded_shard1_replica_n1 url=http://127.0.0.1:52704/solr DONE. We have no versions. sync failed.
[junit4] 2> 817546 INFO (qtp1467008536-9743) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ] o.a.s.c.S.Request [testNodeAdded_shard1_replica_n2] webapp=/solr path=/get params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 817547 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the next candidate
[junit4] 2> 817547 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 817547 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/testNodeAdded/leaders/shard1/leader after winning as /collections/testNodeAdded/leader_elect/shard1/election/72157482958651397-core_node3-n_0000000000
[junit4] 2> 817568 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:52704/solr/testNodeAdded_shard1_replica_n1/ shard1
[junit4] 2> 817570 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "state":"active"} current state version: 0
[junit4] 2> 817657 DEBUG (ScheduledTrigger-2368-thread-2) [ ] o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 817658 DEBUG (ScheduledTrigger-2368-thread-2) [ ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 817674 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/testNodeAdded/state.json version: 2
[junit4] 2> 817676 INFO (zkCallback-3791-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testNodeAdded/state.json] for collection [testNodeAdded] has occurred - updating... (live nodes size: [1])
[junit4] 2> 817676 INFO (zkCallback-3791-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testNodeAdded/state.json] for collection [testNodeAdded] has occurred - updating... (live nodes size: [1])
[junit4] 2> 817677 INFO (zkCallback-3791-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testNodeAdded/state.json] for collection [testNodeAdded] has occurred - updating... (live nodes size: [1])
[junit4] 2> 817683 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 817696 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node3",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "node_name":"127.0.0.1:52704_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 817697 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "core_node_name":"core_node3",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "node_name":"127.0.0.1:52704_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"}
[junit4] 2> 817697 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node3:{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "node_name":"127.0.0.1:52704_solr",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "leader":"true"}
[junit4] 2> 817697 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(testNodeAdded//collections/testNodeAdded/state.json/3)={
[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":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "node_name":"127.0.0.1:52704_solr",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "leader":"true"},
[junit4] 2> "core_node4":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "node_name":"127.0.0.1:52704_solr",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}}}}}
[junit4] 2> 817699 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node3 x:testNodeAdded_shard1_replica_n1 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=testNodeAdded_shard1_replica_n1&action=CREATE&numShards=1&collection=testNodeAdded&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=590
[junit4] 2> 817801 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/testNodeAdded/state.json version: 3
[junit4] 2> 817802 INFO (zkCallback-3791-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testNodeAdded/state.json] for collection [testNodeAdded] has occurred - updating... (live nodes size: [1])
[junit4] 2> 817802 INFO (zkCallback-3791-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testNodeAdded/state.json] for collection [testNodeAdded] has occurred - updating... (live nodes size: [1])
[junit4] 2> 817802 INFO (zkCallback-3791-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testNodeAdded/state.json] for collection [testNodeAdded] has occurred - updating... (live nodes size: [1])
[junit4] 2> 817802 INFO (zkCallback-3791-thread-4) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testNodeAdded/state.json] for collection [testNodeAdded] has occurred - updating... (live nodes size: [1])
[junit4] 2> 818548 INFO (qtp1467008536-9744) [n:127.0.0.1:52704_solr c:testNodeAdded s:shard1 r:core_node4 x:testNodeAdded_shard1_replica_n2 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=testNodeAdded_shard1_replica_n2&action=CREATE&numShards=1&collection=testNodeAdded&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1436
[junit4] 2> 818550 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "core_node_name":"core_node4",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "node_name":"127.0.0.1:52704_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 818550 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "core_node_name":"core_node4",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "node_name":"127.0.0.1:52704_solr",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testNodeAdded",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "operation":"state"}
[junit4] 2> 818550 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node4:{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "node_name":"127.0.0.1:52704_solr",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}
[junit4] 2> 818550 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(testNodeAdded//collections/testNodeAdded/state.json/4)={
[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":{"shard1":{
[junit4] 2> "range":"80000000-7fffffff",
[junit4] 2> "state":"active",
[junit4] 2> "replicas":{
[junit4] 2> "core_node3":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n1",
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "node_name":"127.0.0.1:52704_solr",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false",
[junit4] 2> "leader":"true"},
[junit4] 2> "core_node4":{
[junit4] 2> "core":"testNodeAdded_shard1_replica_n2",
[junit4] 2> "base_url":"http://127.0.0.1:52704/solr",
[junit4] 2> "node_name":"127.0.0.1:52704_solr",
[junit4] 2> "state":"active",
[junit4] 2> "type":"NRT",
[junit4] 2> "force_set_state":"false"}}}}}
[junit4] 2> 818552 INFO (qtp1467008536-9742) [n:127.0.0.1:52704_solr ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 818652 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/testNodeAdded/state.json version: 4
[junit4] 2> 818653 INFO (zkCallback-3791-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testNodeAdded/state.json] for collection [testNodeAdded] has occurred - updating... (live nodes size: [1])
[junit4] 2> 818653 INFO (zkCallback-3791-thread-4) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testNodeAdded/state.json] for collection [testNodeAdded] has occurred - updating... (live nodes size: [1])
[junit4] 2> 818653 INFO (zkCallback-3791-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testNodeAdded/state.json] for collection [testNodeAdded] has occurred - updating... (live nodes size: [1])
[junit4] 2> 818653 INFO (zkCallback-3791-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testNodeAdded/state.json] for collection [testNodeAdded] has occurred - updating... (live nodes size: [1])
[junit4] 2> 818655 INFO (qtp1467008536-9742) [n:127.0.0.1:52704_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=conf&maxShardsPerNode=2&name=testNodeAdded&nrtReplicas=2&action=CREATE&numShards=1&wt=javabin&version=2} status=0 QTime=2019
[junit4] 2> 818657 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.a.s.c.SolrCloudTestCase waitForState (testNodeAdded): Timed out waiting for replicas of new collection to be active
[junit4] 2> 818662 DEBUG (ScheduledTrigger-2368-thread-2) [ ] o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 818662 DEBUG (ScheduledTrigger-2368-thread-2) [ ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 1
[junit4] 2> 818676 INFO (OverseerCollectionConfigSetProcessor-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_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> 818690 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={wt=javabin&version=2&key=solr.core.testNodeAdded.shard1.replica_n1:INDEX.sizeInBytes&key=solr.core.testNodeAdded.shard1.replica_n2:INDEX.sizeInBytes} status=0 QTime=8
[junit4] 2> 818694 INFO (qtp1467008536-9744) [n:127.0.0.1:52704_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=1
[junit4] 2> 818695 DEBUG (qtp1467008536-9743) [n:127.0.0.1:52704_solr ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 818697 INFO (qtp1467008536-9743) [n:127.0.0.1:52704_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=20
[junit4] 2> 818698 WARN (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 818698 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 818698 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 818698 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 14+36
[junit4] 2> 818701 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 818701 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 818701 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 818701 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3c9c47d8{/solr,null,AVAILABLE}
[junit4] 2> 818702 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@3ec0c5ba{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:52721}
[junit4] 2> 818703 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.e.j.s.Server Started @818780ms
[junit4] 2> 818703 DEBUG (zkCallback-3791-thread-1) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 7
[junit4] 2> 818706 DEBUG (OverseerAutoScalingTriggerThread-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 7
[junit4] 2> 818703 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=52721}
[junit4] 2> 818707 ERROR (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 818707 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 818707 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.5.1
[junit4] 2> 818707 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 818707 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr
[junit4] 2> 818707 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-04-14T03:36:28.183744Z
[junit4] 2> 818717 DEBUG (OverseerAutoScalingTriggerThread-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded markers
[junit4] 2> 818720 DEBUG (OverseerAutoScalingTriggerThread-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 7, lastZnodeVersion 7
[junit4] 2> 818722 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 818723 INFO (zkConnectionManagerCallback-3807-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 818723 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 818725 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 819100 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 819104 WARN (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@61ea2544[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 819104 WARN (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@61ea2544[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 819112 WARN (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@68715501[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 819112 WARN (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@68715501[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 819115 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:52699/solr
[junit4] 2> 819119 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 819122 INFO (zkConnectionManagerCallback-3814-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 819122 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 819234 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [n:127.0.0.1:52721_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 819236 INFO (zkConnectionManagerCallback-3816-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 819242 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [n:127.0.0.1:52721_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 819289 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [n:127.0.0.1:52721_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 819337 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [n:127.0.0.1:52721_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:52721_solr as DOWN
[junit4] 2> 819348 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [n:127.0.0.1:52721_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 819349 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [n:127.0.0.1:52721_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:52721_solr
[junit4] 2> 819356 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "operation":"downnode",
[junit4] 2> "node_name":"127.0.0.1:52721_solr"} current state version: 0
[junit4] 2> 819356 DEBUG (OverseerStateUpdate-72157482958651397-127.0.0.1:52704_solr-n_0000000000) [n:127.0.0.1:52704_solr ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 127.0.0.1:52721_solr
[junit4] 2> 819366 INFO (zkCallback-3800-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 819366 INFO (zkCallback-3791-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 819366 INFO (zkCallback-3800-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 819370 INFO (zkCallback-3815-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 819390 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [n:127.0.0.1:52721_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 819393 WARN (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [n:127.0.0.1:52721_solr ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 819440 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [n:127.0.0.1:52721_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 819491 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [n:127.0.0.1:52721_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52721.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7abd9fe5
[junit4] 2> 819507 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [n:127.0.0.1:52721_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52721.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7abd9fe5
[junit4] 2> 819508 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [n:127.0.0.1:52721_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52721.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7abd9fe5
[junit4] 2> 819508 INFO (TEST-ComputePlanActionTest.testNodeAdded-seed#[22A3F8A7030506DC]) [n:127.0.0.1:52721_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.autoscaling.ComputePlanActionTest_22A3F8A7030506DC-001/tempDir-001/node2/.
[junit4] 2> 819664 DEBUG (ScheduledTrigger-2368-thread-2) [ ] o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 819664 DEBUG (ScheduledTrigger-2368-thread-2) [ ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 2
[junit4] 2> 819664 DEBUG (ScheduledTrigger-2368-thread-2) [ ] o.a.s.c.a.NodeAddedTrigger Tracking new node: 127.0.0.1:52721_solr at time 1524188383317704
[junit4] 2> 820680 DEBUG (ScheduledTrigger-2368-thread-2) [ ] o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 820680 DEBUG (ScheduledTrigger-2368-thread-2) [ ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 2
[junit4] 2> 820680 DEBUG (ScheduledTrigger-2368-thread-2) [ ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger firing registered processor for nodes: [127.0.0.1:52721_solr] added at times [1524188383317704], now=1524189399443987
[junit4] 2> 820680 DEBUG (ScheduledTrigger-2368-thread-2) [ ] o.a.s.c.a.ScheduledTriggers ++++++++ Cooldown inactive - processing event: {
[junit4] 2> "id":"56a3dc3288ec8T7m2mac4f6bfyj0xbkm6wg7fcm",
[junit4] 2> "source":"node_added_trigger",
[junit4] 2> "eventTime":1524188383317704,
[junit4] 2> "eventType":"NODEADDED",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[1524188383317704],
[junit4] 2> "preferredOperation":"movereplica",
[junit4] 2> "nodeNames":["127.0.0.1:52721_solr"],
[junit4] 2> "replicaType":"NRT"}}
[junit4] 2> 820683 DEBUG (ScheduledTrigger-2368-thread-2) [ ] o.a.s.c.a.ScheduledTriggers Pausing all triggers: [node_added_trigger]
[junit4] 2> 820699 DEBUG (ScheduledTrigger-2368-thread-2) [ ] o.a.s.c.a.SystemLogListener Collection .system missing, skip sending event {
[junit4] 2> "id":"56a3dc3288ec8T7m2mac4f6bfyj0xbkm6wg7fcm",
[junit4] 2> "source":"node_added_trigger",
[junit4] 2> "eventTime":1524188383317704,
[junit4] 2> "eventType":"NODEADDED",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[1524188383317704],
[junit4] 2> "preferredOperation":"movereplica",
[junit4] 2> "_enqueue_time_":1524189403327818,
[junit4] 2> "nodeNames":["127.0.0.1:52721_solr"],
[junit4] 2> "replicaType":"NRT"}}
[junit4] 2> 820701 DEBUG (ScheduledTrigger-2368-thread-2) [ ] o.a.s.c.a.NodeAddedTrigger Removing new node from tracking: 127.0.0.1:52721_solr
[junit4] 2> 820702 DEBUG (AutoscalingActionExecutor-2369-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -- processing actions for {
[junit4] 2> "id":"56a3dc3288ec8T7m2mac4f6bfyj0xbkm6wg7fcm",
[junit4] 2> "source":"node_added_trigger",
[junit4] 2> "eventTime":1524188383317704,
[junit4] 2> "eventType":"NODEADDED",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[1524188383317704],
[junit4] 2> "preferredOperation":"movereplica",
[junit4] 2> "_enqueue_time_":1524189403327818,
[junit4] 2> "nodeNames":["127.0.0.1:52721_solr"],
[junit4] 2> "replicaType":"NRT"}}
[junit4] 2> 820702 DEBUG (AutoscalingActionExecutor-2369-thread-1) [ ] o.a.s.c.a.ComputePlanAction -- processing event: {
[junit4] 2> "id":"56a3dc3288ec8T7m2mac4f6bfyj0xbkm6wg7fcm",
[junit4] 2> "source":"node_added_trigger",
[junit4] 2> "eventTime":1524188383317704,
[junit4] 2> "eventType":"NODEADDED",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[1524188383317704],
[junit4] 2> "preferredOperation":"movereplica",
[junit4] 2> "_enqueue_time_":1524189403327818,
[junit4] 2> "nodeNames":["127.0.0.1:52721_solr"],
[junit4] 2> "replicaType":"NRT"}} with context properties: {BEFORE_ACTION=[compute_plan]}
[junit4] 2> 820709 INFO (qtp1467008536-9742) [n:127.0.0.1:52704_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={wt=javabin&version=2&key=solr.core.testNodeAdded.shard1.replica_n1:INDEX.sizeInBytes&key=solr.core.testNodeAdded.shard1.replica_n2:INDEX.sizeInBytes} status=0 QTime=1
[junit4] 2> 820716 INFO (qtp1467008536-9741) [n:127.0.0.1:52704_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=1
[junit4] 2> 820725 INFO (qtp228683874-9798) [n:127.0.0.1:52721_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=
[...truncated too long message...]
ard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Core core_node3 was interrupted waiting for schema version 2 to propagate to 1 replicas for collection .system
[junit4] 2> 1850628 INFO (qtp115184546-25468) [n:127.0.0.1:61884_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Took 200766.0ms for 1 replicas to apply schema update version 2 for collection .system
[junit4] 2> 1850628 INFO (qtp115184546-25468) [n:127.0.0.1:61884_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request [.system_shard1_replica_n1] webapp=/solr path=/schema params={wt=javabin&version=2} status=0 QTime=200965
[junit4] 2> 1850628 INFO (qtp115184546-25468) [n:127.0.0.1:61884_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.SolrCore [.system_shard1_replica_n1] CLOSING SolrCore org.apache.solr.core.SolrCore@4b799400
[junit4] 2> 1850628 WARN (qtp115184546-25468) [n:127.0.0.1:61884_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.m.SolrMetricManager Interrupted while trying to obtain lock to modify reporters registry: solr.core..system.shard1.replica_n1
[junit4] 2> 1850628 INFO (qtp115184546-25468) [n:127.0.0.1:61884_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection..system.shard1.leader, tag=SolrCore@4b799400
[junit4] 2> 1850629 INFO (qtp115184546-25468) [n:127.0.0.1:61884_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() .
[junit4] 2> 1850629 INFO (qtp115184546-25468) [n:127.0.0.1:61884_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@73292f47 commitCommandVersion:0
[junit4] 2> 1850630 INFO (httpUriRequest-57690-thread-1-processing-x:.system_shard1_replica_n1 r:core_node3 n:127.0.0.1:61884_solr http:////127.0.0.1:61885//solr//.system_shard1_replica_n2 c:.system s:shard1) [n:127.0.0.1:61884_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.h.i.e.RetryExec I/O exception (java.net.SocketException) caught when processing request to {}->http://127.0.0.1:61885: Socket closed
[junit4] 2> 1850630 INFO (httpUriRequest-57690-thread-1-processing-x:.system_shard1_replica_n1 r:core_node3 n:127.0.0.1:61884_solr http:////127.0.0.1:61885//solr//.system_shard1_replica_n2 c:.system s:shard1) [n:127.0.0.1:61884_solr c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.h.i.e.RetryExec Retrying request to {}->http://127.0.0.1:61885
[junit4] 2> 1850633 INFO (SUITE-SystemCollectionCompatTest-seed#[22A3F8A7030506DC]-worker) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 1850858 WARN (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 9 /solr/configs/.system/managed-schema
[junit4] 2> 8 /solr/clusterprops.json
[junit4] 2> 8 /solr/aliases.json
[junit4] 2> 8 /solr/collections/.system/terms/shard1
[junit4] 2> 6 /solr/configs/.system
[junit4] 2> 5 /solr/collections/.system/collectionprops.json
[junit4] 2> 4 /solr/collections/.system/state.json
[junit4] 2> 2 /solr/packages.json
[junit4] 2> 2 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 30 /solr/collections/.system/state.json
[junit4] 2> 8 /solr/clusterstate.json
[junit4] 2> 5 /solr/aliases.json
[junit4] 2> 3 /solr/configs/.system/managed-schema
[junit4] 2> 2 /solr/autoscaling.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 25 /solr/overseer/queue
[junit4] 2> 16 /solr/collections
[junit4] 2> 16 /solr/overseer/collection-queue-work
[junit4] 2> 14 /solr/live_nodes
[junit4] 2> 2 /solr/autoscaling/events/.scheduled_maintenance
[junit4] 2> 2 /solr/autoscaling/events/.auto_add_replicas
[junit4] 2> 2 /solr/overseer/queue-work
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/solr-core/test/J2/temp/solr.cloud.SystemCollectionCompatTest_22A3F8A7030506DC-001
[junit4] 2> 1850865 INFO (SUITE-SystemCollectionCompatTest-seed#[22A3F8A7030506DC]-worker) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:61878
[junit4] 2> 1850865 INFO (SUITE-SystemCollectionCompatTest-seed#[22A3F8A7030506DC]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:61878
[junit4] 2> 1850865 INFO (SUITE-SystemCollectionCompatTest-seed#[22A3F8A7030506DC]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 61878
[junit4] 2> Apr 14, 2020 3:53:40 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Lucene84, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@64e0e33a), locale=ps-AF, timezone=Asia/Ho_Chi_Minh
[junit4] 2> NOTE: Mac OS X 10.14.6 x86_64/AdoptOpenJDK 14 (64-bit)/cpus=6,threads=1,free=202555312,total=371195904
[junit4] 2> NOTE: All tests run in this JVM: [DistanceFunctionTest, TestSchemaManager, CdcrBootstrapTest, TestReload, TestSmileRequest, BJQFilterAccessibleTest, TestHdfsCloudBackupRestore, TestRetrieveFieldsOptimizer, TestRebalanceLeaders, DeleteStatusTest, TestGraphTermsQParserPlugin, HdfsChaosMonkeySafeLeaderTest, TemplateUpdateProcessorTest, WrapperMergePolicyFactoryTest, TestReplicationHandlerDiskOverFlow, JWTVerificationkeyResolverTest, ChaosMonkeySafeLeaderWithPullReplicasTest, SegmentsInfoRequestHandlerTest, MetricUtilsTest, TestManagedStopFilterFactory, TestSolrFieldCacheBean, TestJmxIntegration, TestFastLRUCache, TestTolerantUpdateProcessorCloud, NodeMarkersRegistrationTest, TestLMJelinekMercerSimilarityFactory, TestWriterPerf, BasicDistributedZkTest, DebugComponentTest, TestStressCloudBlindAtomicUpdates, TransactionLogTest, HttpTriggerListenerTest, GraphQueryTest, SuggesterTest, DistributedUpdateProcessorTest, CoreAdminCreateDiscoverTest, MinimalSchemaTest, DistributedFacetPivotLongTailTest, TestSurroundQueryParser, SpatialRPTFieldTypeTest, TestFieldCollectionResource, TestClassicSimilarityFactory, CollectionsAPIAsyncDistributedZkTest, TestStressLucene, TestAddFieldRealTimeGet, TestZkChroot, TestComponentsName, ZookeeperStatusHandlerTest, TestSimTriggerIntegration, SpellingQueryConverterTest, TestSimLargeCluster, SpellCheckComponentTest, TestCloudSchemaless, TestLuceneMatchVersion, RAMDirectoryFactoryTest, SortByFunctionTest, RandomizedTaggerTest, TestSchemaResource, TestBinaryResponseWriter, TestLRUCache, AutoAddReplicasPlanActionTest, TestSolrConfigHandlerCloud, TestSolrCloudWithHadoopAuthPlugin, CdcrWithNodesRestartsTest, SimplePostToolTest, ImplicitSnitchTest, RecoveryAfterSoftCommitTest, DistributedQueryComponentCustomSortTest, TestDynamicLoadingUrl, TestLeaderElectionZkExpiry, QueryElevationComponentTest, SolrMetricManagerTest, CursorMarkTest, TestCrossCoreJoin, ZkCLITest, MetricTriggerTest, FullHLLTest, TestFaceting, PeerSyncWithBufferUpdatesTest, TestPackages, AtomicUpdateProcessorFactoryTest, NoCacheHeaderTest, TestCloudJSONFacetSKG, SearchRateTriggerIntegrationTest, TestQuerySenderNoQuery, SSLMigrationTest, ActionThrottleTest, TestJoin, TestRandomFaceting, TestSolrCoreProperties, TestSolrTestCaseJ4, PathHierarchyTokenizerFactoryTest, TokenizerChainTest, TestEmbeddedSolrServerAdminHandler, TestEmbeddedSolrServerConstructors, TestEmbeddedSolrServerSchemaAPI, CloudExitableDirectoryReaderTest, CollectionsAPISolrJTest, LeaderElectionTest, LeaderTragicEventTest, LeaderVoteWaitTimeoutTest, OverseerCollectionConfigSetProcessorTest, OverseerModifyCollectionTest, OverseerStatusTest, ReplaceNodeNoTargetTest, ReplaceNodeTest, SystemCollectionCompatTest]
[junit4] Completed [582/900 (2!)] on J2 in 204.70s, 1 test, 1 failure <<< FAILURES!
[...truncated 45863 lines...]
[repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-8.5-MacOSX/60/consoleText
[repro] Revision: edb9fc409398f2c3446883f9f80595c884d245d0
[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseG1GC"
[repro] Repro line: ant test -Dtestcase=ComputePlanActionTest -Dtests.method=testSelectedCollections -Dtests.seed=22A3F8A7030506DC -Dtests.slow=true -Dtests.locale=sv-FI -Dtests.timezone=Europe/Moscow -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[repro] Repro line: ant test -Dtestcase=SystemCollectionCompatTest -Dtests.method=testBackCompat -Dtests.seed=22A3F8A7030506DC -Dtests.slow=true -Dtests.locale=ps-AF -Dtests.timezone=Asia/Ho_Chi_Minh -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[repro] JUnit rest result XML files will be moved to: ./repro-reports
[repro] ant clean
[...truncated 6 lines...]
[repro] Test suites by module:
[repro] solr/core
[repro] SystemCollectionCompatTest
[repro] ComputePlanActionTest
[repro] ant compile-test
[...truncated 3445 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=10 -Dtests.class="*.SystemCollectionCompatTest|*.ComputePlanActionTest" -Dtests.showOutput=onerror "-Dargs=-XX:-UseCompressedOops -XX:+UseG1GC" -Dtests.seed=22A3F8A7030506DC -Dtests.slow=true -Dtests.locale=ps-AF -Dtests.timezone=Asia/Ho_Chi_Minh -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[...truncated 141 lines...]
[repro] Failures w/original seeds:
[repro] 0/5 failed: org.apache.solr.cloud.SystemCollectionCompatTest
[repro] 0/5 failed: org.apache.solr.cloud.autoscaling.ComputePlanActionTest
[repro] Exiting with code 0
[...truncated 73 lines...]
[JENKINS] Lucene-Solr-8.5-MacOSX (64bit/jdk-13.0.2) - Build # 61 -
Still Unstable!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.5-MacOSX/61/
Java: 64bit/jdk-13.0.2 -XX:+UseCompressedOops -XX:+UseConcMarkSweepGC
2 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.TestDistribDocBasedVersion
Error Message:
1 thread leaked from SUITE scope at org.apache.solr.cloud.TestDistribDocBasedVersion: 1) Thread[id=19618, name=SessionTracker, state=TIMED_WAITING, group=TGRP-TestDistribDocBasedVersion] at java.base@13.0.2/java.lang.Thread.sleep(Native Method) at app//org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:151)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.cloud.TestDistribDocBasedVersion:
1) Thread[id=19618, name=SessionTracker, state=TIMED_WAITING, group=TGRP-TestDistribDocBasedVersion]
at java.base@13.0.2/java.lang.Thread.sleep(Native Method)
at app//org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:151)
at __randomizedtesting.SeedInfo.seed([73D5BFFBB8C47EB4]:0)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.api.collections.TestHdfsCloudBackupRestore
Error Message:
6 threads leaked from SUITE scope at org.apache.solr.cloud.api.collections.TestHdfsCloudBackupRestore: 1) Thread[id=11983, name=globalEventExecutor-1-5, state=TIMED_WAITING, group=TGRP-TestHdfsCloudBackupRestore] at java.base@13.0.2/jdk.internal.misc.Unsafe.park(Native Method) at java.base@13.0.2/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:235) at java.base@13.0.2/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2123) at java.base@13.0.2/java.util.concurrent.LinkedBlockingQueue.poll(LinkedBlockingQueue.java:458) at app//io.netty.util.concurrent.GlobalEventExecutor.takeTask(GlobalEventExecutor.java:92) at app//io.netty.util.concurrent.GlobalEventExecutor$TaskRunner.run(GlobalEventExecutor.java:245) at app//io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) at java.base@13.0.2/java.lang.Thread.run(Thread.java:830) 2) Thread[id=11909, name=nioEventLoopGroup-2-4, state=RUNNABLE, group=TGRP-TestHdfsCloudBackupRestore] at java.base@13.0.2/sun.nio.ch.KQueue.poll(Native Method) at java.base@13.0.2/sun.nio.ch.KQueueSelectorImpl.doSelect(KQueueSelectorImpl.java:122) at java.base@13.0.2/sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:124) at java.base@13.0.2/sun.nio.ch.SelectorImpl.select(SelectorImpl.java:136) at app//io.netty.channel.nio.NioEventLoop.select(NioEventLoop.java:737) at app//io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:392) at app//io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:884) at app//io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) at java.base@13.0.2/java.lang.Thread.run(Thread.java:830) 3) Thread[id=11913, name=nioEventLoopGroup-2-8, state=RUNNABLE, group=TGRP-TestHdfsCloudBackupRestore] at java.base@13.0.2/sun.nio.ch.KQueue.poll(Native Method) at java.base@13.0.2/sun.nio.ch.KQueueSelectorImpl.doSelect(KQueueSelectorImpl.java:122) at java.base@13.0.2/sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:124) at java.base@13.0.2/sun.nio.ch.SelectorImpl.select(SelectorImpl.java:136) at app//io.netty.channel.nio.NioEventLoop.select(NioEventLoop.java:737) at app//io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:392) at app//io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:884) at app//io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) at java.base@13.0.2/java.lang.Thread.run(Thread.java:830) 4) Thread[id=11919, name=nioEventLoopGroup-3-2, state=RUNNABLE, group=TGRP-TestHdfsCloudBackupRestore] at java.base@13.0.2/sun.nio.ch.KQueue.poll(Native Method) at java.base@13.0.2/sun.nio.ch.KQueueSelectorImpl.doSelect(KQueueSelectorImpl.java:122) at java.base@13.0.2/sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:124) at java.base@13.0.2/sun.nio.ch.SelectorImpl.select(SelectorImpl.java:136) at app//io.netty.channel.nio.NioEventLoop.select(NioEventLoop.java:737) at app//io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:392) at app//io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:884) at app//io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) at java.base@13.0.2/java.lang.Thread.run(Thread.java:830) 5) Thread[id=11928, name=nioEventLoopGroup-3-11, state=RUNNABLE, group=TGRP-TestHdfsCloudBackupRestore] at java.base@13.0.2/sun.nio.ch.KQueue.poll(Native Method) at java.base@13.0.2/sun.nio.ch.KQueueSelectorImpl.doSelect(KQueueSelectorImpl.java:122) at java.base@13.0.2/sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:124) at java.base@13.0.2/sun.nio.ch.SelectorImpl.select(SelectorImpl.java:136) at app//io.netty.channel.nio.NioEventLoop.select(NioEventLoop.java:737) at app//io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:392) at app//io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:884) at app//io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) at java.base@13.0.2/java.lang.Thread.run(Thread.java:830) 6) Thread[id=11907, name=nioEventLoopGroup-2-2, state=RUNNABLE, group=TGRP-TestHdfsCloudBackupRestore] at java.base@13.0.2/sun.nio.ch.KQueue.poll(Native Method) at java.base@13.0.2/sun.nio.ch.KQueueSelectorImpl.doSelect(KQueueSelectorImpl.java:122) at java.base@13.0.2/sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:124) at java.base@13.0.2/sun.nio.ch.SelectorImpl.select(SelectorImpl.java:136) at app//io.netty.channel.nio.NioEventLoop.select(NioEventLoop.java:737) at app//io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:392) at app//io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:884) at app//io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) at java.base@13.0.2/java.lang.Thread.run(Thread.java:830)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 6 threads leaked from SUITE scope at org.apache.solr.cloud.api.collections.TestHdfsCloudBackupRestore:
1) Thread[id=11983, name=globalEventExecutor-1-5, state=TIMED_WAITING, group=TGRP-TestHdfsCloudBackupRestore]
at java.base@13.0.2/jdk.internal.misc.Unsafe.park(Native Method)
at java.base@13.0.2/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:235)
at java.base@13.0.2/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2123)
at java.base@13.0.2/java.util.concurrent.LinkedBlockingQueue.poll(LinkedBlockingQueue.java:458)
at app//io.netty.util.concurrent.GlobalEventExecutor.takeTask(GlobalEventExecutor.java:92)
at app//io.netty.util.concurrent.GlobalEventExecutor$TaskRunner.run(GlobalEventExecutor.java:245)
at app//io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30)
at java.base@13.0.2/java.lang.Thread.run(Thread.java:830)
2) Thread[id=11909, name=nioEventLoopGroup-2-4, state=RUNNABLE, group=TGRP-TestHdfsCloudBackupRestore]
at java.base@13.0.2/sun.nio.ch.KQueue.poll(Native Method)
at java.base@13.0.2/sun.nio.ch.KQueueSelectorImpl.doSelect(KQueueSelectorImpl.java:122)
at java.base@13.0.2/sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:124)
at java.base@13.0.2/sun.nio.ch.SelectorImpl.select(SelectorImpl.java:136)
at app//io.netty.channel.nio.NioEventLoop.select(NioEventLoop.java:737)
at app//io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:392)
at app//io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:884)
at app//io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30)
at java.base@13.0.2/java.lang.Thread.run(Thread.java:830)
3) Thread[id=11913, name=nioEventLoopGroup-2-8, state=RUNNABLE, group=TGRP-TestHdfsCloudBackupRestore]
at java.base@13.0.2/sun.nio.ch.KQueue.poll(Native Method)
at java.base@13.0.2/sun.nio.ch.KQueueSelectorImpl.doSelect(KQueueSelectorImpl.java:122)
at java.base@13.0.2/sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:124)
at java.base@13.0.2/sun.nio.ch.SelectorImpl.select(SelectorImpl.java:136)
at app//io.netty.channel.nio.NioEventLoop.select(NioEventLoop.java:737)
at app//io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:392)
at app//io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:884)
at app//io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30)
at java.base@13.0.2/java.lang.Thread.run(Thread.java:830)
4) Thread[id=11919, name=nioEventLoopGroup-3-2, state=RUNNABLE, group=TGRP-TestHdfsCloudBackupRestore]
at java.base@13.0.2/sun.nio.ch.KQueue.poll(Native Method)
at java.base@13.0.2/sun.nio.ch.KQueueSelectorImpl.doSelect(KQueueSelectorImpl.java:122)
at java.base@13.0.2/sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:124)
at java.base@13.0.2/sun.nio.ch.SelectorImpl.select(SelectorImpl.java:136)
at app//io.netty.channel.nio.NioEventLoop.select(NioEventLoop.java:737)
at app//io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:392)
at app//io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:884)
at app//io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30)
at java.base@13.0.2/java.lang.Thread.run(Thread.java:830)
5) Thread[id=11928, name=nioEventLoopGroup-3-11, state=RUNNABLE, group=TGRP-TestHdfsCloudBackupRestore]
at java.base@13.0.2/sun.nio.ch.KQueue.poll(Native Method)
at java.base@13.0.2/sun.nio.ch.KQueueSelectorImpl.doSelect(KQueueSelectorImpl.java:122)
at java.base@13.0.2/sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:124)
at java.base@13.0.2/sun.nio.ch.SelectorImpl.select(SelectorImpl.java:136)
at app//io.netty.channel.nio.NioEventLoop.select(NioEventLoop.java:737)
at app//io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:392)
at app//io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:884)
at app//io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30)
at java.base@13.0.2/java.lang.Thread.run(Thread.java:830)
6) Thread[id=11907, name=nioEventLoopGroup-2-2, state=RUNNABLE, group=TGRP-TestHdfsCloudBackupRestore]
at java.base@13.0.2/sun.nio.ch.KQueue.poll(Native Method)
at java.base@13.0.2/sun.nio.ch.KQueueSelectorImpl.doSelect(KQueueSelectorImpl.java:122)
at java.base@13.0.2/sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:124)
at java.base@13.0.2/sun.nio.ch.SelectorImpl.select(SelectorImpl.java:136)
at app//io.netty.channel.nio.NioEventLoop.select(NioEventLoop.java:737)
at app//io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:392)
at app//io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:884)
at app//io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30)
at java.base@13.0.2/java.lang.Thread.run(Thread.java:830)
at __randomizedtesting.SeedInfo.seed([73D5BFFBB8C47EB4]:0)
Build Log:
[...truncated 2285 lines...]
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/core/test/temp/junit4-J3-20200414_112522_3907414473257071876028.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/core/test/temp/junit4-J0-20200414_112522_3907509885698473916726.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 6 lines...]
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/core/test/temp/junit4-J1-20200414_112522_39014024243191190499408.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/core/test/temp/junit4-J2-20200414_112522_3905253681208653435437.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 5 lines...]
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/core/test/temp/junit4-J4-20200414_112522_3908383895462691847121.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[...truncated 306 lines...]
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/test-framework/test/temp/junit4-J3-20200414_112853_54317697066009079362675.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/test-framework/test/temp/junit4-J4-20200414_112853_54412766547910100512845.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[...truncated 3 lines...]
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/test-framework/test/temp/junit4-J2-20200414_112853_54011266377887907032267.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 3 lines...]
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/test-framework/test/temp/junit4-J1-20200414_112853_5396475070111745837740.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 21 lines...]
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/test-framework/test/temp/junit4-J0-20200414_112853_53914963890869788880953.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 1113 lines...]
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/common/test/temp/junit4-J2-20200414_112936_0155307122762595376588.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 3 lines...]
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/common/test/temp/junit4-J3-20200414_112936_000926601343437312972.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/common/test/temp/junit4-J1-20200414_112936_00011116376132152756031.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 6 lines...]
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/common/test/temp/junit4-J4-20200414_112936_0005825429512527116636.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/common/test/temp/junit4-J0-20200414_112936_0004957209365232290036.syserr
[junit4] <<< JVM J4: EOF ----
[...truncated 254 lines...]
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/icu/test/temp/junit4-J3-20200414_113014_7741750500734533786455.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[...truncated 9 lines...]
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/icu/test/temp/junit4-J1-20200414_113014_77215561746516166292810.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/icu/test/temp/junit4-J2-20200414_113014_77215354499910435201606.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 5 lines...]
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/icu/test/temp/junit4-J0-20200414_113014_77211615933417274813426.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 3 lines...]
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/icu/test/temp/junit4-J4-20200414_113014_7766140335986380818716.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[...truncated 224 lines...]
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/kuromoji/test/temp/junit4-J3-20200414_113027_5047953245298412814327.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[...truncated 6 lines...]
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/kuromoji/test/temp/junit4-J1-20200414_113027_54811857578979417771175.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 3 lines...]
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/kuromoji/test/temp/junit4-J2-20200414_113027_5483528957308103669157.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/kuromoji/test/temp/junit4-J4-20200414_113027_51018140132030519587309.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[...truncated 14 lines...]
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/kuromoji/test/temp/junit4-J0-20200414_113027_50418380194169771261900.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 166 lines...]
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/morfologik/test/temp/junit4-J1-20200414_113039_4541746406373354810912.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 6 lines...]
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/morfologik/test/temp/junit4-J0-20200414_113039_4546702171118896021988.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/morfologik/test/temp/junit4-J2-20200414_113039_45415477252654697373952.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 189 lines...]
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/nori/test/temp/junit4-J4-20200414_113045_0786370640854180286677.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/nori/test/temp/junit4-J0-20200414_113045_0752186638269615960703.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 13 lines...]
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/nori/test/temp/junit4-J3-20200414_113045_07711228055855695725573.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/nori/test/temp/junit4-J2-20200414_113045_0765733107483827568410.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/nori/test/temp/junit4-J1-20200414_113045_0759196529467659075829.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 174 lines...]
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/opennlp/test/temp/junit4-J3-20200414_113053_30910933429868953688322.syserr
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/opennlp/test/temp/junit4-J4-20200414_113053_3096602593553347957394.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[...truncated 9 lines...]
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/opennlp/test/temp/junit4-J2-20200414_113053_30817547191625811726710.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/opennlp/test/temp/junit4-J1-20200414_113053_308156158041868791487.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/opennlp/test/temp/junit4-J0-20200414_113053_3085143530009488601939.syserr
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 182 lines...]
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/phonetic/test/temp/junit4-J3-20200414_113057_77710599072500249284533.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/phonetic/test/temp/junit4-J4-20200414_113057_77813648776572501762346.syserr
[junit4] Suite: org.apache.lucene.analysis.phonetic.TestPhoneticFilterFactory
[junit4] Completed [6/8] on J2 in 0.28s, 11 tests
[junit4]
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/phonetic/test/temp/junit4-J2-20200414_113057_7779020219030373922264.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 6 lines...]
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/phonetic/test/temp/junit4-J0-20200414_113057_77616066987933915194436.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/phonetic/test/temp/junit4-J1-20200414_113057_77615654153096674628304.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 165 lines...]
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/smartcn/test/temp/junit4-J0-20200414_113104_97411291073252910603554.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 3 lines...]
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/smartcn/test/temp/junit4-J1-20200414_113104_9748797032254104557009.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 163 lines...]
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/stempel/test/temp/junit4-J3-20200414_113109_83615701060607447381058.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[...truncated 3 lines...]
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/stempel/test/temp/junit4-J2-20200414_113109_8351757117056734315238.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 3 lines...]
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/stempel/test/temp/junit4-J1-20200414_113109_83518120274589934728206.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/analysis/stempel/test/temp/junit4-J0-20200414_113109_83413658524647146639.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 181 lines...]
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/backward-codecs/test/temp/junit4-J1-20200414_113117_40812544456003288252157.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 5 lines...]
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/backward-codecs/test/temp/junit4-J0-20200414_113117_40716664684527605962976.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 11 lines...]
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/backward-codecs/test/temp/junit4-J2-20200414_113117_40815415570888263220478.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 19 lines...]
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/backward-codecs/test/temp/junit4-J4-20200414_113117_41015773046156073354399.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[...truncated 15 lines...]
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/backward-codecs/test/temp/junit4-J3-20200414_113117_41011328002636886540237.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[...truncated 1403 lines...]
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/benchmark/test/temp/junit4-J1-20200414_113344_79618404061840534751495.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 3 lines...]
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/benchmark/test/temp/junit4-J4-20200414_113344_7984634138715131773091.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/benchmark/test/temp/junit4-J3-20200414_113344_7973758945903530051933.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[...truncated 3 lines...]
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/benchmark/test/temp/junit4-J2-20200414_113344_7973339441256024952563.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 3 lines...]
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/benchmark/test/temp/junit4-J0-20200414_113344_7964031619317269218700.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 250 lines...]
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/classification/test/temp/junit4-J2-20200414_113355_29710446297880619614940.syserr
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/classification/test/temp/junit4-J3-20200414_113355_29717290276961292525641.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/classification/test/temp/junit4-J0-20200414_113355_2967085428084460631739.syserr
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 6 lines...]
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/classification/test/temp/junit4-J1-20200414_113355_29617262525363500336541.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/classification/test/temp/junit4-J4-20200414_113355_29810790546495680662673.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[...truncated 319 lines...]
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/codecs/test/temp/junit4-J1-20200414_113402_54010421470644277642841.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 5 lines...]
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/codecs/test/temp/junit4-J3-20200414_113402_5408331645207729621942.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[...truncated 5 lines...]
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/codecs/test/temp/junit4-J2-20200414_113402_5409250031337418508565.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 20 lines...]
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/codecs/test/temp/junit4-J4-20200414_113402_5411246215092264553560.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/codecs/test/temp/junit4-J0-20200414_113402_54011870381431366654566.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 240 lines...]
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/demo/test/temp/junit4-J3-20200414_113453_0534064546365369700798.syserr
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/demo/test/temp/junit4-J0-20200414_113453_0532729711650517344760.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 6 lines...]
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/demo/test/temp/junit4-J1-20200414_113453_05315515789240784694512.syserr
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/demo/test/temp/junit4-J4-20200414_113453_05510071770511589454613.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[...truncated 3 lines...]
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/demo/test/temp/junit4-J2-20200414_113453_05313235814731272885080.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 173 lines...]
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/expressions/test/temp/junit4-J3-20200414_113457_52410510684065266399091.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[...truncated 9 lines...]
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/expressions/test/temp/junit4-J2-20200414_113457_52416351874542002595214.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/expressions/test/temp/junit4-J0-20200414_113457_52311446854985828853946.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/expressions/test/temp/junit4-J1-20200414_113457_523737772838131286887.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 3 lines...]
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/expressions/test/temp/junit4-J4-20200414_113457_52411613099743143399053.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[...truncated 239 lines...]
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/facet/test/temp/junit4-J1-20200414_113503_0098059306931383846212.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/facet/test/temp/junit4-J4-20200414_113503_0105428759177804691400.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[...truncated 6 lines...]
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/facet/test/temp/junit4-J3-20200414_113503_0103438490060114765101.syserr
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/facet/test/temp/junit4-J0-20200414_113503_00916996066586092263341.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[...truncated 6 lines...]
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/facet/test/temp/junit4-J2-20200414_113503_00917711848647852884975.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 185 lines...]
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/grouping/test/temp/junit4-J2-20200414_113518_4112332984958983551775.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 3 lines...]
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/grouping/test/temp/junit4-J4-20200414_113518_4139731330967820082512.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[...truncated 3 lines...]
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/grouping/test/temp/junit4-J3-20200414_113518_4126220355009696014434.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[...truncated 6 lines...]
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/grouping/test/temp/junit4-J0-20200414_113518_41112447328671501637882.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/grouping/test/temp/junit4-J1-20200414_113518_4118074662550395529533.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 248 lines...]
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/highlighter/test/temp/junit4-J2-20200414_113524_398966870879488000125.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/highlighter/test/temp/junit4-J4-20200414_113524_3992122883577786378142.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[...truncated 15 lines...]
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/highlighter/test/temp/junit4-J0-20200414_113524_3975640928291291874148.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 3 lines...]
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/highlighter/test/temp/junit4-J1-20200414_113524_3971401872749607480582.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/highlighter/test/temp/junit4-J3-20200414_113524_39917481395203123469127.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[...truncated 172 lines...]
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/join/test/temp/junit4-J4-20200414_113537_53717738389450836293986.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[...truncated 3 lines...]
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/join/test/temp/junit4-J3-20200414_113537_53613266328065175362916.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/join/test/temp/junit4-J2-20200414_113537_53512500905652572537014.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 6 lines...]
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/join/test/temp/junit4-J0-20200414_113537_53517516951027868935763.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/join/test/temp/junit4-J1-20200414_113537_53518190916364169953804.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 302 lines...]
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/luke/test/temp/junit4-J0-20200414_113546_4375782212073150949662.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 3 lines...]
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/luke/test/temp/junit4-J2-20200414_113546_43712302599355736298359.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 3 lines...]
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/luke/test/temp/junit4-J1-20200414_113546_43712266143526311778529.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 3 lines...]
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/luke/test/temp/junit4-J4-20200414_113546_4447348072687331733914.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[...truncated 3 lines...]
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/luke/test/temp/junit4-J3-20200414_113546_4444404484318289645783.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[...truncated 161 lines...]
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/memory/test/temp/junit4-J0-20200414_113556_7444310126066114717320.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 3 lines...]
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/memory/test/temp/junit4-J1-20200414_113556_74414521713233507370580.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 193 lines...]
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/misc/test/temp/junit4-J2-20200414_113600_4414437597479654494523.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/misc/test/temp/junit4-J3-20200414_113600_4413770781773306949890.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/misc/test/temp/junit4-J1-20200414_113600_44116584284540219198437.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 8 lines...]
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/misc/test/temp/junit4-J0-20200414_113600_4413251542765232366402.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/misc/test/temp/junit4-J4-20200414_113600_44216514888999681073320.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[...truncated 264 lines...]
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/monitor/test/temp/junit4-J1-20200414_113609_337990864757455036096.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/monitor/test/temp/junit4-J4-20200414_113609_3391449019897694212564.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/monitor/test/temp/junit4-J0-20200414_113609_33718318032230983007719.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 3 lines...]
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/monitor/test/temp/junit4-J2-20200414_113609_338515215188199390265.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 3 lines...]
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/monitor/test/temp/junit4-J3-20200414_113609_33816348996795491569302.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[...truncated 248 lines...]
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/queries/test/temp/junit4-J4-20200414_113618_8677233328960374056038.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[...truncated 3 lines...]
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/queries/test/temp/junit4-J2-20200414_113618_8655204506911497653805.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 3 lines...]
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/queries/test/temp/junit4-J0-20200414_113618_86514990843141733920791.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 5 lines...]
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/queries/test/temp/junit4-J1-20200414_113618_8657404935224916502318.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/queries/test/temp/junit4-J3-20200414_113618_86611001466798704087340.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[...truncated 234 lines...]
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/queryparser/test/temp/junit4-J4-20200414_113627_920944498159689697457.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/queryparser/test/temp/junit4-J3-20200414_113627_91911981395485087153832.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[...truncated 3 lines...]
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/queryparser/test/temp/junit4-J0-20200414_113627_9191049596142193994502.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 6 lines...]
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/queryparser/test/temp/junit4-J1-20200414_113627_91914172160966248691888.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/queryparser/test/temp/junit4-J2-20200414_113627_91911183183414149767516.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 196 lines...]
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/replicator/test/temp/junit4-J1-20200414_113637_5966211615585514953112.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 3 lines...]
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/replicator/test/temp/junit4-J0-20200414_113637_5963775822170858324800.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 3 lines...]
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/replicator/test/temp/junit4-J4-20200414_113637_60214718557743328416550.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[...truncated 3 lines...]
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/replicator/test/temp/junit4-J3-20200414_113637_601390473034456408611.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[...truncated 23 lines...]
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/replicator/test/temp/junit4-J2-20200414_113637_5962083086063702848094.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 205 lines...]
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/sandbox/test/temp/junit4-J0-20200414_113648_10715111920242169432697.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/sandbox/test/temp/junit4-J4-20200414_113648_1091717399076247637887.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/sandbox/test/temp/junit4-J1-20200414_113648_10716914214994598654689.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 6 lines...]
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/sandbox/test/temp/junit4-J2-20200414_113648_1076085252365810592605.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/sandbox/test/temp/junit4-J3-20200414_113648_1088153799813131168497.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[...truncated 283 lines...]
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/spatial-extras/test/temp/junit4-J3-20200414_113658_81515810329797382013687.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[...truncated 6 lines...]
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/spatial-extras/test/temp/junit4-J4-20200414_113658_81716425546895743571371.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[...truncated 3 lines...]
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/spatial-extras/test/temp/junit4-J1-20200414_113658_8148126456116466425164.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/spatial-extras/test/temp/junit4-J0-20200414_113658_81414801397701649561971.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 9 lines...]
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/spatial-extras/test/temp/junit4-J2-20200414_113658_8146700984002973014564.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 197 lines...]
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/spatial3d/test/temp/junit4-J3-20200414_113716_82315565025055658369528.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[...truncated 3 lines...]
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/spatial3d/test/temp/junit4-J1-20200414_113716_82114382248766035768462.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/spatial3d/test/temp/junit4-J0-20200414_113716_8217424463613603243764.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 3 lines...]
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/spatial3d/test/temp/junit4-J4-20200414_113716_82317209617993160316797.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[...truncated 5 lines...]
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/spatial3d/test/temp/junit4-J2-20200414_113716_82216284999365005221590.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 261 lines...]
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/suggest/test/temp/junit4-J2-20200414_113725_0579448127284943542969.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 12 lines...]
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/suggest/test/temp/junit4-J1-20200414_113725_05714570981957294852082.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/suggest/test/temp/junit4-J0-20200414_113725_0571913669503191117412.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/suggest/test/temp/junit4-J4-20200414_113725_0593065810401364021727.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/lucene/build/suggest/test/temp/junit4-J3-20200414_113725_05813666760339500373488.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[...truncated 2693 lines...]
[junit4] Suite: org.apache.solr.cloud.api.collections.TestHdfsCloudBackupRestore
[junit4] 2> 560905 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/server/solr/configsets/_default/conf'
[junit4] 2> 560905 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.TestHdfsCloudBackupRestore_73D5BFFBB8C47EB4-001/data-dir-44-001
[junit4] 2> 560905 WARN (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=18 numCloses=18
[junit4] 2> 560906 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 560906 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, clientAuth=0.0/0.0) w/ MAC_OS_X supressed clientAuth
[junit4] 2> 560907 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 1> Formatting using clusterid: testClusterID
[junit4] 2> 562343 WARN (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 562370 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 13.0.2+8
[junit4] 2> 562377 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 562377 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 562378 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 562384 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7341cfaf{static,/static,jar:file:/Users/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.0-tests.jar!/webapps/static,AVAILABLE}
[junit4] 2> 562743 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.w.WebAppContext@2e13aff8{hdfs,/,file:///Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/solr-core/test/J2/temp/jetty-localhost-52247-hadoop-hdfs-3_2_0-tests_jar-_-any-10246864485581266692.dir/webapp/,AVAILABLE}{jar:file:/Users/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.0-tests.jar!/webapps/hdfs}
[junit4] 2> 562745 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.e.j.s.AbstractConnector Started ServerConnector@10d99122{HTTP/1.1,[http/1.1]}{localhost:52247}
[junit4] 2> 562745 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.e.j.s.Server Started @562793ms
[junit4] 2> 563470 WARN (StorageLocationChecker thread 0) [ ] o.a.h.u.NativeCodeLoader Unable to load native-hadoop library for your platform... using builtin-java classes where applicable
[junit4] 2> 563543 WARN (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 563549 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 13.0.2+8
[junit4] 2> 563549 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 563549 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 563549 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 563549 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@29e9f6d4{static,/static,jar:file:/Users/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.0-tests.jar!/webapps/static,AVAILABLE}
[junit4] 2> 563697 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.w.WebAppContext@54de0c10{datanode,/,file:///Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/solr-core/test/J2/temp/jetty-localhost-52252-hadoop-hdfs-3_2_0-tests_jar-_-any-1116218865001894667.dir/webapp/,AVAILABLE}{jar:file:/Users/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.0-tests.jar!/webapps/datanode}
[junit4] 2> 563697 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.e.j.s.AbstractConnector Started ServerConnector@57900db0{HTTP/1.1,[http/1.1]}{localhost:52252}
[junit4] 2> 563697 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.e.j.s.Server Started @563745ms
[junit4] 2> 563977 WARN (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 563980 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 13.0.2+8
[junit4] 2> 563982 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 563982 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 563982 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 563983 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@14922b30{static,/static,jar:file:/Users/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.0-tests.jar!/webapps/static,AVAILABLE}
[junit4] 2> 564189 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.w.WebAppContext@4442ade1{datanode,/,file:///Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/solr-core/test/J2/temp/jetty-localhost-52270-hadoop-hdfs-3_2_0-tests_jar-_-any-15668734836162322088.dir/webapp/,AVAILABLE}{jar:file:/Users/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.0-tests.jar!/webapps/datanode}
[junit4] 2> 564189 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.e.j.s.AbstractConnector Started ServerConnector@330932e4{HTTP/1.1,[http/1.1]}{localhost:52270}
[junit4] 2> 564194 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.e.j.s.Server Started @564242ms
[junit4] 2> 564682 INFO (Block report processor) [ ] BlockStateChange BLOCK* processReport 0x4412b629fdf57350: Processing first storage report for DS-2f6a67b5-2b04-4872-a026-3ed993e878eb from datanode 95ed098a-b17d-4035-a8ed-b59ddbab1c5f
[junit4] 2> 564683 INFO (Block report processor) [ ] BlockStateChange BLOCK* processReport 0x4412b629fdf57350: from storage DS-2f6a67b5-2b04-4872-a026-3ed993e878eb node DatanodeRegistration(127.0.0.1:52269, datanodeUuid=95ed098a-b17d-4035-a8ed-b59ddbab1c5f, infoPort=52275, infoSecurePort=0, ipcPort=52276, storageInfo=lv=-57;cid=testClusterID;nsid=132674474;c=1586864861058), blocks: 0, hasStaleStorage: true, processing time: 1 msecs, invalidatedBlocks: 0
[junit4] 2> 564683 INFO (Block report processor) [ ] BlockStateChange BLOCK* processReport 0x4412b629fdf57350: Processing first storage report for DS-2b9d4752-2151-4ed8-af8d-61445b89e251 from datanode 95ed098a-b17d-4035-a8ed-b59ddbab1c5f
[junit4] 2> 564683 INFO (Block report processor) [ ] BlockStateChange BLOCK* processReport 0x4412b629fdf57350: from storage DS-2b9d4752-2151-4ed8-af8d-61445b89e251 node DatanodeRegistration(127.0.0.1:52269, datanodeUuid=95ed098a-b17d-4035-a8ed-b59ddbab1c5f, infoPort=52275, infoSecurePort=0, ipcPort=52276, storageInfo=lv=-57;cid=testClusterID;nsid=132674474;c=1586864861058), blocks: 0, hasStaleStorage: false, processing time: 0 msecs, invalidatedBlocks: 0
[junit4] 2> 564685 INFO (Block report processor) [ ] BlockStateChange BLOCK* processReport 0xae3763dab61b6df1: Processing first storage report for DS-f5f1b157-47cc-4cbb-8b77-489d5beaf16d from datanode eb915b3c-e70a-4212-a75c-0323817c21f0
[junit4] 2> 564685 INFO (Block report processor) [ ] BlockStateChange BLOCK* processReport 0xae3763dab61b6df1: from storage DS-f5f1b157-47cc-4cbb-8b77-489d5beaf16d node DatanodeRegistration(127.0.0.1:52251, datanodeUuid=eb915b3c-e70a-4212-a75c-0323817c21f0, infoPort=52267, infoSecurePort=0, ipcPort=52268, storageInfo=lv=-57;cid=testClusterID;nsid=132674474;c=1586864861058), blocks: 0, hasStaleStorage: true, processing time: 0 msecs, invalidatedBlocks: 0
[junit4] 2> 564686 INFO (Block report processor) [ ] BlockStateChange BLOCK* processReport 0xae3763dab61b6df1: Processing first storage report for DS-24b1a480-d0bd-4b4e-999a-89dc5770a293 from datanode eb915b3c-e70a-4212-a75c-0323817c21f0
[junit4] 2> 564686 INFO (Block report processor) [ ] BlockStateChange BLOCK* processReport 0xae3763dab61b6df1: from storage DS-24b1a480-d0bd-4b4e-999a-89dc5770a293 node DatanodeRegistration(127.0.0.1:52251, datanodeUuid=eb915b3c-e70a-4212-a75c-0323817c21f0, infoPort=52267, infoSecurePort=0, ipcPort=52268, storageInfo=lv=-57;cid=testClusterID;nsid=132674474;c=1586864861058), blocks: 0, hasStaleStorage: false, processing time: 0 msecs, invalidatedBlocks: 0
[junit4] 2> 565101 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/solr-core/test/J2/temp/solr.cloud.api.collections.TestHdfsCloudBackupRestore_73D5BFFBB8C47EB4-001/tempDir-002
[junit4] 2> 565101 INFO (SUITE-TestHdfsCloudBackupRestore-seed#[73D5BFFBB8C47EB4]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 565102 INFO (ZkTestServer Run Thread) [
[...truncated too long message...]
uture release.
[junit4] <<< JVM J0: EOF ----
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/contrib/solr-langid/test/temp/junit4-J3-20200414_121644_97013859614169043042354.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/contrib/solr-langid/test/temp/junit4-J1-20200414_121644_9697314257152810745187.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 686 lines...]
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/contrib/solr-ltr/test/temp/junit4-J0-20200414_121658_19116056562822046860468.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/contrib/solr-ltr/test/temp/junit4-J1-20200414_121658_1917799769071645083518.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 3 lines...]
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/contrib/solr-ltr/test/temp/junit4-J4-20200414_121658_1928530264858946749482.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[...truncated 3 lines...]
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/contrib/solr-ltr/test/temp/junit4-J3-20200414_121658_1911830930974361341466.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[...truncated 3 lines...]
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/contrib/solr-ltr/test/temp/junit4-J2-20200414_121658_1913425606659394637885.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 583 lines...]
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/contrib/solr-prometheus-exporter/test/temp/junit4-J0-20200414_121738_8772875625259157554992.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 16 lines...]
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/contrib/solr-prometheus-exporter/test/temp/junit4-J2-20200414_121738_87812599985314156011321.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/contrib/solr-prometheus-exporter/test/temp/junit4-J1-20200414_121738_8778665846438692522834.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 3 lines...]
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/contrib/solr-prometheus-exporter/test/temp/junit4-J4-20200414_121738_87811610775391505614198.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[...truncated 3 lines...]
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/contrib/solr-prometheus-exporter/test/temp/junit4-J3-20200414_121738_87813018452138827333582.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[...truncated 570 lines...]
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/contrib/solr-velocity/test/temp/junit4-J0-20200414_121757_4357433335778431640950.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 38399 lines...]
[repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-8.5-MacOSX/61/consoleText
[repro] Revision: edb9fc409398f2c3446883f9f80595c884d245d0
[repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UseConcMarkSweepGC"
[repro] Repro line: ant test -Dtestcase=TestHdfsCloudBackupRestore -Dtests.seed=73D5BFFBB8C47EB4 -Dtests.slow=true -Dtests.locale=ln -Dtests.timezone=Europe/Lisbon -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[repro] Repro line: ant test -Dtestcase=TestDistribDocBasedVersion -Dtests.seed=73D5BFFBB8C47EB4 -Dtests.slow=true -Dtests.locale=sv-AX -Dtests.timezone=Asia/Makassar -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[repro] JUnit rest result XML files will be moved to: ./repro-reports
[repro] ant clean
[...truncated 6 lines...]
[repro] Test suites by module:
[repro] solr/core
[repro] TestDistribDocBasedVersion
[repro] TestHdfsCloudBackupRestore
[repro] ant compile-test
[...truncated 3445 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=10 -Dtests.class="*.TestDistribDocBasedVersion|*.TestHdfsCloudBackupRestore" -Dtests.showOutput=onerror "-Dargs=-XX:+UseCompressedOops -XX:+UseConcMarkSweepGC" -Dtests.seed=73D5BFFBB8C47EB4 -Dtests.slow=true -Dtests.locale=sv-AX -Dtests.timezone=Asia/Makassar -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[...truncated 59 lines...]
[junit4] JVM J3: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/solr-core/test/temp/junit4-J3-20200414_122250_2328211277641115317687.syserr
[junit4] >>> JVM J3 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J3: EOF ----
[...truncated 5 lines...]
[junit4] JVM J2: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/solr-core/test/temp/junit4-J2-20200414_122250_2329890506654777723321.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 10 lines...]
[junit4] JVM J1: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/solr-core/test/temp/junit4-J1-20200414_122250_23210145290282297339218.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[junit4] JVM J0: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/solr-core/test/temp/junit4-J0-20200414_122250_23510259887355767590617.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 5 lines...]
[junit4] JVM J4: stderr was not empty, see: /Users/jenkins/workspace/Lucene-Solr-8.5-MacOSX/solr/build/solr-core/test/temp/junit4-J4-20200414_122250_232886433383956871561.syserr
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J4: EOF ----
[...truncated 27 lines...]
[repro] Failures w/original seeds:
[repro] 0/5 failed: org.apache.solr.cloud.TestDistribDocBasedVersion
[repro] 0/5 failed: org.apache.solr.cloud.api.collections.TestHdfsCloudBackupRestore
[repro] Exiting with code 0
[...truncated 73 lines...]