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/08/20 22:12:39 UTC
[JENKINS-Experimental-GC] Lucene-Solr-8.x-MacOSX (64bit/jdk-14.0.1)
- Build # 1417 - Still Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-MacOSX/1417/
Java: 64bit/jdk-14.0.1 -XX:+UseCompressedOops -XX:+UnlockExperimentalVMOptions -XX:+UseZGC
3 tests failed.
FAILED: org.apache.solr.cloud.TestCryptoKeys.test
Error Message:
{ "responseHeader":{ "status":500, "QTime":30546}, "errorMessages":["4 out of 5 the property overlay to be of version 0 within 30 seconds! Failed cores: [http://127.0.0.1:60126/t/collection1_shard1_replica_n1/, http://127.0.0.1:60144/t/collection1_shard1_replica_n3/, http://127.0.0.1:60160/t/collection1_shard1_replica_n5/, http://127.0.0.1:60133/t/collection1_shard1_replica_n7/]\n"], "WARNING":"This response format is experimental. It is likely to change in the future.", "error":{ "metadata":[ "error-class","org.apache.solr.common.SolrException", "root-error-class","org.apache.solr.common.SolrException"], "msg":"4 out of 5 the property overlay to be of version 0 within 30 seconds! Failed cores: [http://127.0.0.1:60126/t/collection1_shard1_replica_n1/, http://127.0.0.1:60144/t/collection1_shard1_replica_n3/, http://127.0.0.1:60160/t/collection1_shard1_replica_n5/, http://127.0.0.1:60133/t/collection1_shard1_replica_n7/]", "trace":"org.apache.solr.common.SolrException: 4 out of 5 the property overlay to be of version 0 within 30 seconds! Failed cores: [http://127.0.0.1:60126/t/collection1_shard1_replica_n1/, http://127.0.0.1:60144/t/collection1_shard1_replica_n3/, http://127.0.0.1:60160/t/collection1_shard1_replica_n5/, http://127.0.0.1:60133/t/collection1_shard1_replica_n7/]\n\tat org.apache.solr.handler.SolrConfigHandler.waitForAllReplicasState(SolrConfigHandler.java:843)\n\tat org.apache.solr.handler.SolrConfigHandler.access$400(SolrConfigHandler.java:104)\n\tat org.apache.solr.handler.SolrConfigHandler$Command.handleCommands(SolrConfigHandler.java:545)\n\tat org.apache.solr.handler.SolrConfigHandler$Command.handlePOST(SolrConfigHandler.java:377)\n\tat org.apache.solr.handler.SolrConfigHandler$Command.access$100(SolrConfigHandler.java:162)\n\tat org.apache.solr.handler.SolrConfigHandler.handleRequestBody(SolrConfigHandler.java:139)\n\tat org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:214)\n\tat org.apache.solr.core.SolrCore.execute(SolrCore.java:2618)\n\tat org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:812)\n\tat org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:588)\n\tat org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:415)\n\tat org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:345)\n\tat org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604)\n\tat org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:166)\n\tat org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604)\n\tat org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:545)\n\tat org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)\n\tat org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1610)\n\tat org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)\n\tat org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1300)\n\tat org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188)\n\tat org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:485)\n\tat org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1580)\n\tat org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186)\n\tat org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1215)\n\tat org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)\n\tat org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)\n\tat org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:322)\n\tat org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:717)\n\tat org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)\n\tat org.eclipse.jetty.server.Server.handle(Server.java:500)\n\tat org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:383)\n\tat org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:547)\n\tat org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:375)\n\tat org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:273)\n\tat org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311)\n\tat org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103)\n\tat org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:117)\n\tat org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:806)\n\tat org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:938)\n\tat java.base/java.lang.Thread.run(Thread.java:832)\n", "code":500}} expected null, but was:<[4 out of 5 the property overlay to be of version 0 within 30 seconds! Failed cores: [http://127.0.0.1:60126/t/collection1_shard1_replica_n1/, http://127.0.0.1:60144/t/collection1_shard1_replica_n3/, http://127.0.0.1:60160/t/collection1_shard1_replica_n5/, http://127.0.0.1:60133/t/collection1_shard1_replica_n7/] ]>
Stack Trace:
java.lang.AssertionError: {
"responseHeader":{
"status":500,
"QTime":30546},
"errorMessages":["4 out of 5 the property overlay to be of version 0 within 30 seconds! Failed cores: [http://127.0.0.1:60126/t/collection1_shard1_replica_n1/, http://127.0.0.1:60144/t/collection1_shard1_replica_n3/, http://127.0.0.1:60160/t/collection1_shard1_replica_n5/, http://127.0.0.1:60133/t/collection1_shard1_replica_n7/]\n"],
"WARNING":"This response format is experimental. It is likely to change in the future.",
"error":{
"metadata":[
"error-class","org.apache.solr.common.SolrException",
"root-error-class","org.apache.solr.common.SolrException"],
"msg":"4 out of 5 the property overlay to be of version 0 within 30 seconds! Failed cores: [http://127.0.0.1:60126/t/collection1_shard1_replica_n1/, http://127.0.0.1:60144/t/collection1_shard1_replica_n3/, http://127.0.0.1:60160/t/collection1_shard1_replica_n5/, http://127.0.0.1:60133/t/collection1_shard1_replica_n7/]",
"trace":"org.apache.solr.common.SolrException: 4 out of 5 the property overlay to be of version 0 within 30 seconds! Failed cores: [http://127.0.0.1:60126/t/collection1_shard1_replica_n1/, http://127.0.0.1:60144/t/collection1_shard1_replica_n3/, http://127.0.0.1:60160/t/collection1_shard1_replica_n5/, http://127.0.0.1:60133/t/collection1_shard1_replica_n7/]\n\tat org.apache.solr.handler.SolrConfigHandler.waitForAllReplicasState(SolrConfigHandler.java:843)\n\tat org.apache.solr.handler.SolrConfigHandler.access$400(SolrConfigHandler.java:104)\n\tat org.apache.solr.handler.SolrConfigHandler$Command.handleCommands(SolrConfigHandler.java:545)\n\tat org.apache.solr.handler.SolrConfigHandler$Command.handlePOST(SolrConfigHandler.java:377)\n\tat org.apache.solr.handler.SolrConfigHandler$Command.access$100(SolrConfigHandler.java:162)\n\tat org.apache.solr.handler.SolrConfigHandler.handleRequestBody(SolrConfigHandler.java:139)\n\tat org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:214)\n\tat org.apache.solr.core.SolrCore.execute(SolrCore.java:2618)\n\tat org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:812)\n\tat org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:588)\n\tat org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:415)\n\tat org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:345)\n\tat org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604)\n\tat org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:166)\n\tat org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604)\n\tat org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:545)\n\tat org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)\n\tat org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1610)\n\tat org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)\n\tat org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1300)\n\tat org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188)\n\tat org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:485)\n\tat org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1580)\n\tat org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186)\n\tat org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1215)\n\tat org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)\n\tat org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)\n\tat org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:322)\n\tat org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:717)\n\tat org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)\n\tat org.eclipse.jetty.server.Server.handle(Server.java:500)\n\tat org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:383)\n\tat org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:547)\n\tat org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:375)\n\tat org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:273)\n\tat org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311)\n\tat org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103)\n\tat org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:117)\n\tat org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:806)\n\tat org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:938)\n\tat java.base/java.lang.Thread.run(Thread.java:832)\n",
"code":500}}
expected null, but was:<[4 out of 5 the property overlay to be of version 0 within 30 seconds! Failed cores: [http://127.0.0.1:60126/t/collection1_shard1_replica_n1/, http://127.0.0.1:60144/t/collection1_shard1_replica_n3/, http://127.0.0.1:60160/t/collection1_shard1_replica_n5/, http://127.0.0.1:60133/t/collection1_shard1_replica_n7/]
]>
at __randomizedtesting.SeedInfo.seed([12306D97BCA6331E:9A64524D125A5EE6]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.failNotNull(Assert.java:755)
at org.junit.Assert.assertNull(Assert.java:737)
at org.apache.solr.core.TestSolrConfigHandler.runConfigCommand(TestSolrConfigHandler.java:180)
at org.apache.solr.cloud.TestCryptoKeys.test(TestCryptoKeys.java:107)
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 org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1090)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1061)
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: junit.framework.TestSuite.org.apache.solr.client.solrj.io.stream.MathExpressionTest
Error Message:
1 thread leaked from SUITE scope at org.apache.solr.client.solrj.io.stream.MathExpressionTest: 1) Thread[id=3753, name=SessionTracker, state=TIMED_WAITING, group=TGRP-MathExpressionTest] at java.base@14.0.1/java.lang.Thread.sleep(Native Method) at app//org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:157)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.client.solrj.io.stream.MathExpressionTest:
1) Thread[id=3753, name=SessionTracker, state=TIMED_WAITING, group=TGRP-MathExpressionTest]
at java.base@14.0.1/java.lang.Thread.sleep(Native Method)
at app//org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:157)
at __randomizedtesting.SeedInfo.seed([4BAFBBB545C72ABC]:0)
FAILED: junit.framework.TestSuite.org.apache.solr.client.solrj.io.stream.StreamExpressionTest
Error Message:
1 thread leaked from SUITE scope at org.apache.solr.client.solrj.io.stream.StreamExpressionTest: 1) Thread[id=3052, name=SessionTracker, state=TIMED_WAITING, group=TGRP-StreamExpressionTest] at java.base@14.0.1/java.lang.Thread.sleep(Native Method) at app//org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:157)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.client.solrj.io.stream.StreamExpressionTest:
1) Thread[id=3052, name=SessionTracker, state=TIMED_WAITING, group=TGRP-StreamExpressionTest]
at java.base@14.0.1/java.lang.Thread.sleep(Native Method)
at app//org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:157)
at __randomizedtesting.SeedInfo.seed([4BAFBBB545C72ABC]:0)
Build Log:
[...truncated 15274 lines...]
[junit4] Suite: org.apache.solr.cloud.TestCryptoKeys
[junit4] 2> 1393131 INFO (SUITE-TestCryptoKeys-seed#[12306D97BCA6331E]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/server/solr/configsets/_default/conf'
[junit4] 2> 1393133 INFO (SUITE-TestCryptoKeys-seed#[12306D97BCA6331E]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.TestCryptoKeys_12306D97BCA6331E-001/data-dir-144-001
[junit4] 2> 1393134 INFO (SUITE-TestCryptoKeys-seed#[12306D97BCA6331E]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 1393137 INFO (SUITE-TestCryptoKeys-seed#[12306D97BCA6331E]-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> 1393138 INFO (SUITE-TestCryptoKeys-seed#[12306D97BCA6331E]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1393138 INFO (SUITE-TestCryptoKeys-seed#[12306D97BCA6331E]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /t/
[junit4] 2> 1393150 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1393151 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 1393151 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1393156 WARN (ZkTestServer Run Thread) [ ] o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
[junit4] 2> 1393252 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.ZkTestServer start zk server on port: 60043
[junit4] 2> 1393252 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:60043
[junit4] 2> 1393252 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:60043
[junit4] 2> 1393252 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 60043
[junit4] 2> 1393258 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1393262 INFO (zkConnectionManagerCallback-11092-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1393263 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1393270 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1393273 INFO (zkConnectionManagerCallback-11094-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1393274 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1393278 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.ZkTestServer put /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml
[junit4] 2> 1393282 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.ZkTestServer put /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
[junit4] 2> 1393288 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.ZkTestServer put /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1393292 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.ZkTestServer put /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
[junit4] 2> 1393305 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.ZkTestServer put /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
[junit4] 2> 1393312 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.ZkTestServer put /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
[junit4] 2> 1393319 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.ZkTestServer put /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml
[junit4] 2> 1393325 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.ZkTestServer put /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4] 2> 1393330 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.ZkTestServer put /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 1393339 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.ZkTestServer put /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4] 2> 1393345 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.ZkTestServer put /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
[junit4] 2> 1393351 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Will use NRT replicas unless explicitly asked otherwise
[junit4] 2> 1394285 WARN (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 1394286 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1394286 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1394286 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 14.0.1+7
[junit4] 2> 1394307 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1394308 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1394309 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1394311 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@45c0b0d0{/t,null,AVAILABLE}
[junit4] 2> 1394313 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@7e254b1a{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:60058}
[junit4] 2> 1394313 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.e.j.s.Server Started @1394440ms
[junit4] 2> 1394313 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/t, solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.TestCryptoKeys_12306D97BCA6331E-001/tempDir-001/control/data, hostPort=60058, coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.TestCryptoKeys_12306D97BCA6331E-001/control-001/cores, replicaType=NRT}
[junit4] 2> 1394313 ERROR (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1394313 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1394313 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.7.0
[junit4] 2> 1394314 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1394314 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr
[junit4] 2> 1394314 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-08-20T21:31:11.642089Z
[junit4] 2> 1394323 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1394325 INFO (zkConnectionManagerCallback-11096-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1394327 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1394336 WARN (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]-SendThread(127.0.0.1:60043)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x100a0b875db0002.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x100a0b875db0002, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x100a0b875db0002, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75) ~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:348) ~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1262) [zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> 1394442 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 1394442 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.TestCryptoKeys_12306D97BCA6331E-001/control-001/solr.xml
[junit4] 2> 1394453 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1394453 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1394454 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@2d4e2ed4, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1394542 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 1394544 WARN (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@5742f849[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1394544 WARN (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@5742f849[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1394551 WARN (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@2c1b3433[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1394551 WARN (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@2c1b3433[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1394553 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:60043/solr
[junit4] 2> 1394562 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1394565 INFO (zkConnectionManagerCallback-11106-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1394566 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1394582 WARN (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]-SendThread(127.0.0.1:60043)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x100a0b875db0003.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x100a0b875db0003, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x100a0b875db0003, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75) ~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:348) ~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1262) [zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> 1394692 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [n:127.0.0.1:60058_t ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1394699 INFO (zkConnectionManagerCallback-11108-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1394699 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [n:127.0.0.1:60058_t ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1396025 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [n:127.0.0.1:60058_t ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:60058_t
[junit4] 2> 1396039 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [n:127.0.0.1:60058_t ] o.a.s.c.Overseer Overseer (id=72234308149641220-127.0.0.1:60058_t-n_0000000000) starting
[junit4] 2> 1396178 INFO (OverseerStateUpdate-72234308149641220-127.0.0.1:60058_t-n_0000000000) [n:127.0.0.1:60058_t ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:60058_t
[junit4] 2> 1396180 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [n:127.0.0.1:60058_t ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60058_t
[junit4] 2> 1396187 INFO (OverseerStateUpdate-72234308149641220-127.0.0.1:60058_t-n_0000000000) [n:127.0.0.1:60058_t ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1396214 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [n:127.0.0.1:60058_t ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 1396215 WARN (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [n:127.0.0.1:60058_t ] 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> 1396249 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [n:127.0.0.1:60058_t ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1396310 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [n:127.0.0.1:60058_t ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2d4e2ed4
[junit4] 2> 1396331 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [n:127.0.0.1:60058_t ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2d4e2ed4
[junit4] 2> 1396332 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [n:127.0.0.1:60058_t ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2d4e2ed4
[junit4] 2> 1396334 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [n:127.0.0.1:60058_t ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.TestCryptoKeys_12306D97BCA6331E-001/control-001/cores
[junit4] 2> 1396362 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1396366 INFO (zkConnectionManagerCallback-11125-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1396366 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1396375 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1396386 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:60043/solr ready
[junit4] 2> 1396391 INFO (qtp940172356-19278) [n:127.0.0.1:60058_t ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:60058_t&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1396414 INFO (OverseerThreadFactory-11115-thread-1-processing-n:127.0.0.1:60058_t) [n:127.0.0.1:60058_t ] o.a.s.c.a.c.CreateCollectionCmd Create collection control_collection
[junit4] 2> 1396554 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t x:control_collection_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1396555 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t x:control_collection_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1397593 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.7.0
[junit4] 2> 1397622 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 1398319 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1398492 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore 'control_collection_shard1_replica_n1' using configuration from configset conf1, trusted=true
[junit4] 2> 1398494 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.control_collection.shard1.replica_n1' (registry 'solr.core.control_collection.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2d4e2ed4
[junit4] 2> 1398494 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SolrCore [[control_collection_shard1_replica_n1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.TestCryptoKeys_12306D97BCA6331E-001/control-001/cores/control_collection_shard1_replica_n1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.TestCryptoKeys_12306D97BCA6331E-001/control-001/cores/control_collection_shard1_replica_n1/data/]
[junit4] 2> 1398497 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=39, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 1398503 WARN (qtp940172356-19277) [n:127.0.0.1:60058_t c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 1398591 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1398591 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1398600 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1398600 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1398601 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=30, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.44675575621686314]
[junit4] 2> 1398621 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 1398622 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1398623 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 1398625 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1675581536026492928
[junit4] 2> 1398653 INFO (searcherExecutor-11127-thread-1-processing-n:127.0.0.1:60058_t x:control_collection_shard1_replica_n1 c:control_collection s:shard1) [n:127.0.0.1:60058_t c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SolrCore [control_collection_shard1_replica_n1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 1398694 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/control_collection/terms/shard1 to Terms{values={core_node2=0}, version=0}
[junit4] 2> 1398694 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/control_collection/leaders/shard1
[junit4] 2> 1398764 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1398764 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1398764 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:60058/t/control_collection_shard1_replica_n1/
[junit4] 2> 1398772 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 1398776 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy http://127.0.0.1:60058/t/control_collection_shard1_replica_n1/ has no replicas
[junit4] 2> 1398776 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/control_collection/leaders/shard1/leader after winning as /collections/control_collection/leader_elect/shard1/election/72234308149641220-core_node2-n_0000000000
[junit4] 2> 1398813 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:60058/t/control_collection_shard1_replica_n1/ shard1
[junit4] 2> 1398823 INFO (zkCallback-11107-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1398824 INFO (zkCallback-11107-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1398837 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1398856 INFO (qtp940172356-19277) [n:127.0.0.1:60058_t ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=2302
[junit4] 2> 1398865 INFO (qtp940172356-19278) [n:127.0.0.1:60058_t ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 1398962 INFO (zkCallback-11107-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1398962 INFO (zkCallback-11107-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1398962 INFO (zkCallback-11107-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1398967 INFO (qtp940172356-19278) [n:127.0.0.1:60058_t ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:60058_t&wt=javabin&version=2} status=0 QTime=2577
[junit4] 2> 1398968 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Waiting to see 1 active replicas in collection: control_collection
[junit4] 2> 1399093 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1399097 INFO (zkConnectionManagerCallback-11136-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1399097 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1399112 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1399119 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:60043/solr ready
[junit4] 2> 1399119 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false
[junit4] 2> 1399121 INFO (qtp940172356-19278) [n:127.0.0.1:60058_t ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=&stateFormat=2&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1399157 INFO (OverseerThreadFactory-11115-thread-2-processing-n:127.0.0.1:60058_t) [n:127.0.0.1:60058_t ] o.a.s.c.a.c.CreateCollectionCmd Create collection collection1
[junit4] 2> 1399167 INFO (OverseerCollectionConfigSetProcessor-72234308149641220-127.0.0.1:60058_t-n_0000000000) [n:127.0.0.1:60058_t ] 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> 1399403 WARN (OverseerThreadFactory-11115-thread-2-processing-n:127.0.0.1:60058_t) [n:127.0.0.1:60058_t ] o.a.s.c.a.c.CreateCollectionCmd It is unusual to create a collection (collection1) without cores.
[junit4] 2> 1399409 INFO (qtp940172356-19278) [n:127.0.0.1:60058_t ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 1399413 INFO (qtp940172356-19278) [n:127.0.0.1:60058_t ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=&stateFormat=2&wt=javabin&version=2} status=0 QTime=291
[junit4] 2> 1399415 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.SolrCloudTestCase active slice count: 1 expected: 1
[junit4] 2> 1399415 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 1399416 INFO (watches-11133-thread-1) [ ] o.a.s.c.SolrCloudTestCase active slice count: 1 expected: 1
[junit4] 2> 1399416 INFO (watches-11133-thread-1) [ ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 1399417 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.SolrCloudTestCase active slice count: 1 expected: 1
[junit4] 2> 1399417 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 1399418 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.SolrCloudTestCase active slice count: 1 expected: 1
[junit4] 2> 1399418 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 1399418 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Creating jetty instances pullReplicaCount=0 numOtherReplicas=4
[junit4] 2> 1400285 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.TestCryptoKeys_12306D97BCA6331E-001/shard-1-001 of type NRT for shard1
[junit4] 2> 1400287 WARN (closeThreadPool-11137-thread-1) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 1400287 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1400287 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1400288 INFO (closeThreadPool-11137-thread-1) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 14.0.1+7
[junit4] 2> 1400293 INFO (closeThreadPool-11137-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1400293 INFO (closeThreadPool-11137-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1400293 INFO (closeThreadPool-11137-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1400294 INFO (closeThreadPool-11137-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@39b40f2a{/t,null,AVAILABLE}
[junit4] 2> 1400295 INFO (closeThreadPool-11137-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@25390431{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:60126}
[junit4] 2> 1400295 INFO (closeThreadPool-11137-thread-1) [ ] o.e.j.s.Server Started @1400422ms
[junit4] 2> 1400295 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/t, solrconfig=solrconfig.xml, solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.TestCryptoKeys_12306D97BCA6331E-001/tempDir-001/jetty1, hostPort=60126, coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.TestCryptoKeys_12306D97BCA6331E-001/shard-1-001/cores}
[junit4] 2> 1400295 ERROR (closeThreadPool-11137-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1400295 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1400296 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.7.0
[junit4] 2> 1400296 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1400296 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr
[junit4] 2> 1400296 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-08-20T21:31:17.624093Z
[junit4] 2> 1400298 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1400302 INFO (zkConnectionManagerCallback-11139-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1400302 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1400305 WARN (closeThreadPool-11137-thread-1-SendThread(127.0.0.1:60043)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x100a0b875db0007.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x100a0b875db0007, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x100a0b875db0007, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75) ~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:348) ~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1262) [zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> 1400406 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 1400406 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.TestCryptoKeys_12306D97BCA6331E-001/shard-1-001/solr.xml
[junit4] 2> 1400415 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1400415 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1400416 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@2d4e2ed4, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1400589 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 1400596 WARN (closeThreadPool-11137-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@770f8742[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1400596 WARN (closeThreadPool-11137-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@770f8742[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1400618 WARN (closeThreadPool-11137-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@2c11a507[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1400625 WARN (closeThreadPool-11137-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@2c11a507[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1400628 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:60043/solr
[junit4] 2> 1400641 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1400647 INFO (zkConnectionManagerCallback-11149-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1400648 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1400654 WARN (closeThreadPool-11137-thread-1-SendThread(127.0.0.1:60043)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x100a0b875db0008.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x100a0b875db0008, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x100a0b875db0008, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75) ~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:348) ~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1262) [zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> 1400765 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60126_t ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1400769 INFO (zkConnectionManagerCallback-11151-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1400773 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60126_t ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1400833 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60126_t ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1400908 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60126_t ] o.a.s.c.ZkController Publish node=127.0.0.1:60126_t as DOWN
[junit4] 2> 1400945 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60126_t ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1400945 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60126_t ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60126_t
[junit4] 2> 1400970 INFO (zkCallback-11135-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1400970 INFO (zkCallback-11107-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1400971 INFO (zkCallback-11150-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1401004 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60126_t ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 1401006 WARN (closeThreadPool-11137-thread-1) [n:127.0.0.1:60126_t ] 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> 1401056 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60126_t ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1401154 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60126_t ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2d4e2ed4
[junit4] 2> 1401175 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60126_t ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2d4e2ed4
[junit4] 2> 1401175 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60126_t ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2d4e2ed4
[junit4] 2> 1401179 INFO (OverseerCollectionConfigSetProcessor-72234308149641220-127.0.0.1:60058_t-n_0000000000) [n:127.0.0.1:60058_t ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 1401195 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60126_t ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.TestCryptoKeys_12306D97BCA6331E-001/shard-1-001/cores
[junit4] 2> 1401225 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.AbstractFullDistribZkTestBase waitForLiveNode: 127.0.0.1:60126_t
[junit4] 2> 1401316 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.TestCryptoKeys_12306D97BCA6331E-001/shard-2-001 of type NRT for shard1
[junit4] 2> 1401323 WARN (closeThreadPool-11137-thread-1) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 1401324 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1401324 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1401324 INFO (closeThreadPool-11137-thread-1) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 14.0.1+7
[junit4] 2> 1401332 INFO (closeThreadPool-11137-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1401332 INFO (closeThreadPool-11137-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1401332 INFO (closeThreadPool-11137-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1401335 INFO (closeThreadPool-11137-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@53622c7f{/t,null,AVAILABLE}
[junit4] 2> 1401341 INFO (closeThreadPool-11137-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@60bde014{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:60133}
[junit4] 2> 1401341 INFO (closeThreadPool-11137-thread-1) [ ] o.e.j.s.Server Started @1401467ms
[junit4] 2> 1401341 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/t, solrconfig=solrconfig.xml, solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.TestCryptoKeys_12306D97BCA6331E-001/tempDir-001/jetty2, hostPort=60133, coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.TestCryptoKeys_12306D97BCA6331E-001/shard-2-001/cores, replicaType=NRT}
[junit4] 2> 1401341 ERROR (closeThreadPool-11137-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1401341 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1401341 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.7.0
[junit4] 2> 1401341 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1401341 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr
[junit4] 2> 1401341 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-08-20T21:31:18.669788Z
[junit4] 2> 1401344 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1401355 INFO (zkConnectionManagerCallback-11161-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1401355 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1401364 WARN (closeThreadPool-11137-thread-1-SendThread(127.0.0.1:60043)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x100a0b875db000a.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x100a0b875db000a, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x100a0b875db000a, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75) ~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:348) ~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1262) [zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> 1401466 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 1401466 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.TestCryptoKeys_12306D97BCA6331E-001/shard-2-001/solr.xml
[junit4] 2> 1401471 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1401471 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1401472 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@2d4e2ed4, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1401636 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 1401646 WARN (closeThreadPool-11137-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@4514a984[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1401646 WARN (closeThreadPool-11137-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@4514a984[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1401660 WARN (closeThreadPool-11137-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@591f527[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1401660 WARN (closeThreadPool-11137-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@591f527[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1401664 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:60043/solr
[junit4] 2> 1401675 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1401681 INFO (zkConnectionManagerCallback-11171-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1401682 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1401687 WARN (closeThreadPool-11137-thread-1-SendThread(127.0.0.1:60043)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x100a0b875db000b.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x100a0b875db000b, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x100a0b875db000b, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75) ~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:348) ~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1262) [zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> 1401801 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60133_t ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1401803 INFO (zkConnectionManagerCallback-11173-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1401804 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60133_t ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1401839 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60133_t ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1401880 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60133_t ] o.a.s.c.ZkController Publish node=127.0.0.1:60133_t as DOWN
[junit4] 2> 1401891 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60133_t ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1401891 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60133_t ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60133_t
[junit4] 2> 1401907 INFO (zkCallback-11150-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1401907 INFO (zkCallback-11135-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1401907 INFO (zkCallback-11172-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1401907 INFO (zkCallback-11107-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1401935 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60133_t ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 1401936 WARN (closeThreadPool-11137-thread-1) [n:127.0.0.1:60133_t ] 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> 1401979 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60133_t ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1402014 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60133_t ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2d4e2ed4
[junit4] 2> 1402027 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60133_t ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2d4e2ed4
[junit4] 2> 1402027 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60133_t ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2d4e2ed4
[junit4] 2> 1402028 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60133_t ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.TestCryptoKeys_12306D97BCA6331E-001/shard-2-001/cores
[junit4] 2> 1402047 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.AbstractFullDistribZkTestBase waitForLiveNode: 127.0.0.1:60133_t
[junit4] 2> 1402076 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 3 in directory /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.TestCryptoKeys_12306D97BCA6331E-001/shard-3-001 of type NRT for shard1
[junit4] 2> 1402079 WARN (closeThreadPool-11137-thread-1) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 1402080 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1402080 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1402080 INFO (closeThreadPool-11137-thread-1) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 14.0.1+7
[junit4] 2> 1402089 INFO (closeThreadPool-11137-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1402089 INFO (closeThreadPool-11137-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1402089 INFO (closeThreadPool-11137-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1402090 INFO (closeThreadPool-11137-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@78743b4e{/t,null,AVAILABLE}
[junit4] 2> 1402095 INFO (closeThreadPool-11137-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@53f93ee2{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:60144}
[junit4] 2> 1402096 INFO (closeThreadPool-11137-thread-1) [ ] o.e.j.s.Server Started @1402222ms
[junit4] 2> 1402096 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/t, solrconfig=solrconfig.xml, solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.TestCryptoKeys_12306D97BCA6331E-001/tempDir-001/jetty3, hostPort=60144, coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.TestCryptoKeys_12306D97BCA6331E-001/shard-3-001/cores}
[junit4] 2> 1402096 ERROR (closeThreadPool-11137-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1402096 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1402096 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.7.0
[junit4] 2> 1402096 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1402096 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr
[junit4] 2> 1402096 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-08-20T21:31:19.424644Z
[junit4] 2> 1402101 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1402102 INFO (zkConnectionManagerCallback-11183-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1402102 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1402105 WARN (closeThreadPool-11137-thread-1-SendThread(127.0.0.1:60043)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x100a0b875db000d.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x100a0b875db000d, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x100a0b875db000d, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75) ~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:348) ~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1262) [zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> 1402207 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 1402207 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.TestCryptoKeys_12306D97BCA6331E-001/shard-3-001/solr.xml
[junit4] 2> 1402213 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1402213 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1402216 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@2d4e2ed4, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1402334 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 1402336 WARN (closeThreadPool-11137-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@51e8f53e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1402336 WARN (closeThreadPool-11137-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@51e8f53e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1402348 WARN (closeThreadPool-11137-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@3fdec777[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1402348 WARN (closeThreadPool-11137-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@3fdec777[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1402358 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:60043/solr
[junit4] 2> 1402362 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1402367 INFO (zkConnectionManagerCallback-11193-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1402367 INFO (closeThreadPool-11137-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1402376 WARN (closeThreadPool-11137-thread-1-SendThread(127.0.0.1:60043)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x100a0b875db000e.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x100a0b875db000e, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x100a0b875db000e, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75) ~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:348) ~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1262) [zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> 1402485 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60144_t ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1402494 INFO (zkConnectionManagerCallback-11195-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1402495 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60144_t ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1402550 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60144_t ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 1402575 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60144_t ] o.a.s.c.ZkController Publish node=127.0.0.1:60144_t as DOWN
[junit4] 2> 1402585 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60144_t ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1402585 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60144_t ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60144_t
[junit4] 2> 1402595 INFO (zkCallback-11172-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1402595 INFO (zkCallback-11107-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1402596 INFO (zkCallback-11150-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1402596 INFO (zkCallback-11135-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1402596 INFO (zkCallback-11194-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1402608 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60144_t ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 1402608 WARN (closeThreadPool-11137-thread-1) [n:127.0.0.1:60144_t ] 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> 1402643 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60144_t ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1402680 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60144_t ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2d4e2ed4
[junit4] 2> 1402689 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60144_t ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2d4e2ed4
[junit4] 2> 1402689 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60144_t ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2d4e2ed4
[junit4] 2> 1402690 INFO (closeThreadPool-11137-thread-1) [n:127.0.0.1:60144_t ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.TestCryptoKeys_12306D97BCA6331E-001/shard-3-001/cores
[junit4] 2> 1402693 INFO (TEST-TestCryptoKeys.test-seed#[12306D97BCA6331E]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 4 in directory /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.TestCryptoKeys_12306D97BCA6331E-001/shard-4-001 of type NRT for shard1
[junit4] 2> 1402697 WARN (closeThreadPool-11137-thread-2) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 1402697 INFO (closeThreadPool-11137-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1402697 INFO (closeThreadPool-11137-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 1402697 INFO (closeThreadPool-11137-thread-2) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 14.0.1+7
[junit4] 2> 1402700 INFO (closeThreadPool-11137-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1402700 INFO (closeThreadPool-11137-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1402700 INFO (closeThreadPool-11137-thread-2) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1402700 INFO (closeThreadPool-11137-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@189c6b21{/t,null,AVAILABLE}
[junit4] 2> 1402701 INFO (closeThreadPool-11137-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5e6c9e1d{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:60160}
[junit4] 2> 1402701 INFO (closeThreadPool-11137-thread-2) [ ] o.e.j.s.Server Started @1402828ms
[junit4] 2> 1402701 INFO (closeThreadPool-11137-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/t, solrconfig=solrconfig.xml, solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J4/temp/solr.cloud.TestCryptoKeys_1230
[...truncated too long message...]
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:348) ~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1262) [zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> 290399 WARN (SUITE-MathExpressionTest-seed#[4BAFBBB545C72ABC]-worker-SendThread(127.0.0.1:54214)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x100a0d012560001.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x100a0d012560001, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x100a0d012560001, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75) ~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:348) ~[zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1262) [zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> 290513 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> 7 /solr/aliases.json
[junit4] 2> 7 /solr/clusterprops.json
[junit4] 2> 4 /solr/packages.json
[junit4] 2> 4 /solr/security.json
[junit4] 2> 3 /solr/collections/collection1_collection/terms/shard1
[junit4] 2> 3 /solr/collections/collection1_collection/terms/shard2
[junit4] 2> 2 /solr/collections/collection1_collection/collectionprops.json
[junit4] 2> 2 /solr/configs/conf
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 31 /solr/collections/collection1_collection/state.json
[junit4] 2> 7 /solr/clusterstate.json
[junit4] 2> 5 /solr/aliases.json
[junit4] 2> 2 /solr/overseer_elect/election/72234409559195661-127.0.0.1:54219_solr-n_0000000000
[junit4] 2> 2 /solr/overseer_elect/election/72234409559195660-127.0.0.1:54220_solr-n_0000000001
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 27 /solr/live_nodes
[junit4] 2> 19 /solr/overseer/queue
[junit4] 2> 12 /solr/collections
[junit4] 2> 8 /solr/overseer/collection-queue-work
[junit4] 2>
[junit4] 2> 290518 INFO (SUITE-MathExpressionTest-seed#[4BAFBBB545C72ABC]-worker) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:54214
[junit4] 2> 290518 INFO (SUITE-MathExpressionTest-seed#[4BAFBBB545C72ABC]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:54214
[junit4] 2> 290518 INFO (SUITE-MathExpressionTest-seed#[4BAFBBB545C72ABC]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 54214
[junit4] 2> 290519 INFO (SUITE-MathExpressionTest-seed#[4BAFBBB545C72ABC]-worker) [ ] o.a.s.SolrTestCaseJ4 ------------------------------------------------------- Done waiting for tracked resources to be released
[junit4] 2> Aug 20, 2020 9:57:53 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> Aug 20, 2020 9:58:03 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> SEVERE: 1 thread leaked from SUITE scope at org.apache.solr.client.solrj.io.stream.MathExpressionTest:
[junit4] 2> 1) Thread[id=3753, name=SessionTracker, state=TIMED_WAITING, group=TGRP-MathExpressionTest]
[junit4] 2> at java.base@14.0.1/java.lang.Thread.sleep(Native Method)
[junit4] 2> at app//org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:157)
[junit4] 2> Aug 20, 2020 9:58:03 PM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: Starting to interrupt leaked threads:
[junit4] 2> 1) Thread[id=3753, name=SessionTracker, state=TIMED_WAITING, group=TGRP-MathExpressionTest]
[junit4] 2> 300724 ERROR (SessionTracker) [ ] o.a.z.s.ZooKeeperCriticalThread Severe unrecoverable error, from thread : SessionTracker
[junit4] 2> => java.lang.InterruptedException: sleep interrupted
[junit4] 2> at java.base/java.lang.Thread.sleep(Native Method)
[junit4] 2> java.lang.InterruptedException: sleep interrupted
[junit4] 2> at java.lang.Thread.sleep(Native Method) ~[?:?]
[junit4] 2> at org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:157) [zookeeper-3.6.1.jar:3.6.1]
[junit4] 2> Aug 20, 2020 9:58:03 PM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: All leaked threads terminated.
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene86): {test_t=PostingsFormat(name=Asserting), col_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), multiDefault=PostingsFormat(name=LuceneFixedGap), id=PostingsFormat(name=Asserting), text=Lucene84}, docValues:{col_s=DocValuesFormat(name=Lucene80), order_i=DocValuesFormat(name=Direct), _version_=DocValuesFormat(name=Lucene80), multiDefault=DocValuesFormat(name=Direct), price_f=DocValuesFormat(name=Direct), intDefault=DocValuesFormat(name=Lucene80), test_dt=DocValuesFormat(name=Lucene80), id=DocValuesFormat(name=Asserting), price_i=DocValuesFormat(name=Asserting), miles_i=DocValuesFormat(name=Lucene80), timestamp=DocValuesFormat(name=Direct)}, maxPointsInLeafNode=1687, maxMBSortInHeap=7.594857676004523, sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=fr-CM, timezone=SST
[junit4] 2> NOTE: Mac OS X 10.14.6 x86_64/AdoptOpenJDK 14.0.1 (64-bit)/cpus=6,threads=1,free=266338304,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [LessThanEvaluatorTest, ExclusiveOrEvaluatorTest, TestValidatingJsonMap, SchemaTest, TestPolicyOld, ArcCosineEvaluatorTest, SolrExampleStreamingHttp2Test, TestToleratedUpdateError, TestJSONParser, UsingSolrJRefGuideExamplesTest, TestBatchUpdate, TestZkConfigManager, SquareRootEvaluatorTest, TestV2Request, JsonQueryRequestFacetingIntegrationTest, TestDelegationTokenRequest, CeilingEvaluatorTest, NormalizeEvaluatorTest, CubedRootEvaluatorTest, HttpSolrClientSSLAuthConPoolTest, GraphTest, JDBCStreamTest, MathExpressionTest]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=MathExpressionTest -Dtests.seed=4BAFBBB545C72ABC -Dtests.slow=true -Dtests.locale=fr-CM -Dtests.timezone=SST -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.00s J2 | MathExpressionTest (suite) <<<
[junit4] > Throwable #1: com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.client.solrj.io.stream.MathExpressionTest:
[junit4] > 1) Thread[id=3753, name=SessionTracker, state=TIMED_WAITING, group=TGRP-MathExpressionTest]
[junit4] > at java.base@14.0.1/java.lang.Thread.sleep(Native Method)
[junit4] > at app//org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:157)
[junit4] > at __randomizedtesting.SeedInfo.seed([4BAFBBB545C72ABC]:0)
[junit4] Completed [152/210 (2!)] on J2 in 65.70s, 141 tests, 1 error <<< FAILURES!
[...truncated 43884 lines...]
[repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-MacOSX/1417/consoleText
[repro] Revision: fae87d2d562df64af0d8b690af8d6386f58c63ad
[repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UnlockExperimentalVMOptions -XX:+UseZGC"
[repro] Repro line: ant test -Dtestcase=TestCryptoKeys -Dtests.method=test -Dtests.seed=12306D97BCA6331E -Dtests.slow=true -Dtests.locale=yi-001 -Dtests.timezone=Asia/Baghdad -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[repro] Repro line: ant test -Dtestcase=StreamExpressionTest -Dtests.seed=4BAFBBB545C72ABC -Dtests.slow=true -Dtests.locale=sr-Cyrl -Dtests.timezone=Asia/Pyongyang -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[repro] Repro line: ant test -Dtestcase=MathExpressionTest -Dtests.seed=4BAFBBB545C72ABC -Dtests.slow=true -Dtests.locale=fr-CM -Dtests.timezone=SST -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[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] TestCryptoKeys
[repro] solr/solrj
[repro] StreamExpressionTest
[repro] MathExpressionTest
[repro] ant compile-test
[...truncated 3452 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.TestCryptoKeys" -Dtests.showOutput=onerror "-Dargs=-XX:+UseCompressedOops -XX:+UnlockExperimentalVMOptions -XX:+UseZGC" -Dtests.seed=12306D97BCA6331E -Dtests.slow=true -Dtests.locale=yi-001 -Dtests.timezone=Asia/Baghdad -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[...truncated 86 lines...]
[repro] ant compile-test
[...truncated 451 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=10 -Dtests.class="*.StreamExpressionTest|*.MathExpressionTest" -Dtests.showOutput=onerror "-Dargs=-XX:+UseCompressedOops -XX:+UnlockExperimentalVMOptions -XX:+UseZGC" -Dtests.seed=4BAFBBB545C72ABC -Dtests.slow=true -Dtests.locale=sr-Cyrl -Dtests.timezone=Asia/Pyongyang -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[...truncated 971 lines...]
[repro] Failures w/original seeds:
[repro] 0/5 failed: org.apache.solr.client.solrj.io.stream.MathExpressionTest
[repro] 0/5 failed: org.apache.solr.client.solrj.io.stream.StreamExpressionTest
[repro] 0/5 failed: org.apache.solr.cloud.TestCryptoKeys
[repro] Exiting with code 0
[...truncated 91 lines...]