Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/4167/

2 tests failed.
FAILED:  org.apache.solr.cloud.SystemCollectionCompatTest.testBackCompat

Error Message:
No live SolrServers available to handle this 
request:[http://127.0.0.1:46214/solr/.system]

Stack Trace:
org.apache.solr.client.solrj.SolrServerException: No live SolrServers available 
to handle this request:[http://127.0.0.1:46214/solr/.system]
        at 
__randomizedtesting.SeedInfo.seed([A484CB35D215396B:D471689CB2DD901D]:0)
        at 
org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:345)
        at 
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.sendRequest(BaseCloudSolrClient.java:1143)
        at 
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:906)
        at 
org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:838)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:207)
        at 
org.apache.solr.cloud.SystemCollectionCompatTest.setupSystemCollection(SystemCollectionCompatTest.java:118)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:566)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:976)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992)
        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:370)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:819)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:470)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:951)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898)
        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:370)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
        at java.base/java.lang.Thread.run(Thread.java:834)
Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occurred 
while waiting response from server at: http://127.0.0.1:46214/solr/.system
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:676)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:265)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
        at 
org.apache.solr.client.solrj.impl.LBSolrClient.doRequest(LBSolrClient.java:368)
        at 
org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:296)
        ... 43 more
Caused by: java.net.SocketTimeoutException: Read timed out
        at java.base/java.net.SocketInputStream.socketRead0(Native Method)
        at 
java.base/java.net.SocketInputStream.socketRead(SocketInputStream.java:115)
        at java.base/java.net.SocketInputStream.read(SocketInputStream.java:168)
        at java.base/java.net.SocketInputStream.read(SocketInputStream.java:140)
        at 
org.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInputBufferImpl.java:137)
        at 
org.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInputBufferImpl.java:153)
        at 
org.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputBufferImpl.java:280)
        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:138)
        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56)
        at 
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259)
        at 
org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163)
        at 
org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:157)
        at 
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273)
        at 
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125)
        at 
org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272)
        at 
org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:186)
        at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89)
        at 
org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
        at 
org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:564)
        ... 47 more


FAILED:  org.apache.solr.cloud.autoscaling.AutoScalingHandlerTest.testReadApi

Error Message:
expected:<2> but was:<3>

Stack Trace:
java.lang.AssertionError: expected:<2> but was:<3>
        at 
__randomizedtesting.SeedInfo.seed([A484CB35D215396B:F3AD308009E7DB70]:0)
        at org.junit.Assert.fail(Assert.java:88)
        at org.junit.Assert.failNotEquals(Assert.java:834)
        at org.junit.Assert.assertEquals(Assert.java:645)
        at org.junit.Assert.assertEquals(Assert.java:631)
        at 
org.apache.solr.cloud.autoscaling.AutoScalingHandlerTest.testReadApi(AutoScalingHandlerTest.java:898)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:566)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:942)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:978)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992)
        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:370)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:819)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:470)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:951)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898)
        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:370)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
        at java.base/java.lang.Thread.run(Thread.java:834)




Build Log:
[...truncated 13543 lines...]
   [junit4] Suite: org.apache.solr.cloud.autoscaling.AutoScalingHandlerTest
   [junit4]   2> 1643374 INFO  
(SUITE-AutoScalingHandlerTest-seed#[A484CB35D215396B]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_A484CB35D215396B-001/data-dir-124-001
   [junit4]   2> 1643374 WARN  
(SUITE-AutoScalingHandlerTest-seed#[A484CB35D215396B]-worker) [     ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
   [junit4]   2> 1643374 INFO  
(SUITE-AutoScalingHandlerTest-seed#[A484CB35D215396B]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 1643375 INFO  
(SUITE-AutoScalingHandlerTest-seed#[A484CB35D215396B]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) 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)
   [junit4]   2> 1643376 INFO  
(SUITE-AutoScalingHandlerTest-seed#[A484CB35D215396B]-worker) [     ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 1643376 INFO  
(SUITE-AutoScalingHandlerTest-seed#[A484CB35D215396B]-worker) [     ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_A484CB35D215396B-001/tempDir-001
   [junit4]   2> 1643376 INFO  
(SUITE-AutoScalingHandlerTest-seed#[A484CB35D215396B]-worker) [     ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1643377 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1643377 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 1643477 INFO  
(SUITE-AutoScalingHandlerTest-seed#[A484CB35D215396B]-worker) [     ] 
o.a.s.c.ZkTestServer start zk server on port:37838
   [junit4]   2> 1643477 INFO  
(SUITE-AutoScalingHandlerTest-seed#[A484CB35D215396B]-worker) [     ] 
o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:37838
   [junit4]   2> 1643477 INFO  
(SUITE-AutoScalingHandlerTest-seed#[A484CB35D215396B]-worker) [     ] 
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:37838
   [junit4]   2> 1643477 INFO  
(SUITE-AutoScalingHandlerTest-seed#[A484CB35D215396B]-worker) [     ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1 37838
   [junit4]   2> 1643479 INFO  
(SUITE-AutoScalingHandlerTest-seed#[A484CB35D215396B]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1643481 INFO  (zkConnectionManagerCallback-8152-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1643481 INFO  
(SUITE-AutoScalingHandlerTest-seed#[A484CB35D215396B]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1643484 INFO  
(SUITE-AutoScalingHandlerTest-seed#[A484CB35D215396B]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1643485 INFO  (zkConnectionManagerCallback-8154-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1643485 INFO  
(SUITE-AutoScalingHandlerTest-seed#[A484CB35D215396B]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1643486 INFO  
(SUITE-AutoScalingHandlerTest-seed#[A484CB35D215396B]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1643487 INFO  (zkConnectionManagerCallback-8156-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1643487 INFO  
(SUITE-AutoScalingHandlerTest-seed#[A484CB35D215396B]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1643594 WARN  (jetty-launcher-8157-thread-1) [     ] 
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, 
break even is size 23
   [junit4]   2> 1643594 INFO  (jetty-launcher-8157-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1643594 INFO  (jetty-launcher-8157-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 1643594 INFO  (jetty-launcher-8157-thread-1) [     ] 
o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 
363d5f2df3a8a28de40604320230664b9c793c16; jvm 11.0.4+10-LTS
   [junit4]   2> 1643596 WARN  (jetty-launcher-8157-thread-2) [     ] 
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, 
break even is size 23
   [junit4]   2> 1643597 INFO  (jetty-launcher-8157-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1643597 INFO  (jetty-launcher-8157-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 1643597 INFO  (jetty-launcher-8157-thread-2) [     ] 
o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 
363d5f2df3a8a28de40604320230664b9c793c16; jvm 11.0.4+10-LTS
   [junit4]   2> 1643598 INFO  (jetty-launcher-8157-thread-1) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1643598 INFO  (jetty-launcher-8157-thread-1) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1643598 INFO  (jetty-launcher-8157-thread-1) [     ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1643598 INFO  (jetty-launcher-8157-thread-2) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1643598 INFO  (jetty-launcher-8157-thread-2) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1643598 INFO  (jetty-launcher-8157-thread-2) [     ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1643599 INFO  (jetty-launcher-8157-thread-1) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1c37b43{/solr,null,AVAILABLE}
   [junit4]   2> 1643599 INFO  (jetty-launcher-8157-thread-2) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@51393c35{/solr,null,AVAILABLE}
   [junit4]   2> 1643600 INFO  (jetty-launcher-8157-thread-2) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@4371a577{ssl,[ssl, alpn, 
http/1.1, h2]}{127.0.0.1:36887}
   [junit4]   2> 1643600 INFO  (jetty-launcher-8157-thread-1) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@4bcf814b{ssl,[ssl, alpn, 
http/1.1, h2]}{127.0.0.1:39501}
   [junit4]   2> 1643600 INFO  (jetty-launcher-8157-thread-2) [     ] 
o.e.j.s.Server Started @1643809ms
   [junit4]   2> 1643600 INFO  (jetty-launcher-8157-thread-1) [     ] 
o.e.j.s.Server Started @1643809ms
   [junit4]   2> 1643600 INFO  (jetty-launcher-8157-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=39501}
   [junit4]   2> 1643600 INFO  (jetty-launcher-8157-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=36887}
   [junit4]   2> 1643600 ERROR (jetty-launcher-8157-thread-2) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1643600 ERROR (jetty-launcher-8157-thread-1) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1643600 INFO  (jetty-launcher-8157-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1643600 INFO  (jetty-launcher-8157-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1643600 INFO  (jetty-launcher-8157-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
9.0.0
   [junit4]   2> 1643600 INFO  (jetty-launcher-8157-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
9.0.0
   [junit4]   2> 1643601 INFO  (jetty-launcher-8157-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1643601 INFO  (jetty-launcher-8157-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr
   [junit4]   2> 1643601 INFO  (jetty-launcher-8157-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-02-05T18:51:01.834025Z
   [junit4]   2> 1643601 INFO  (jetty-launcher-8157-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1643601 INFO  (jetty-launcher-8157-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr
   [junit4]   2> 1643601 INFO  (jetty-launcher-8157-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-02-05T18:51:01.834058Z
   [junit4]   2> 1643602 INFO  (jetty-launcher-8157-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1643602 INFO  (jetty-launcher-8157-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1643603 INFO  (zkConnectionManagerCallback-8160-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1643603 INFO  (jetty-launcher-8157-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1643603 INFO  (zkConnectionManagerCallback-8161-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1643603 INFO  (jetty-launcher-8157-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1643604 INFO  (jetty-launcher-8157-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1643604 INFO  (jetty-launcher-8157-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1644430 INFO  (jetty-launcher-8157-thread-2) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 1644433 WARN  (jetty-launcher-8157-thread-2) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@183bcda6[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1644433 WARN  (jetty-launcher-8157-thread-2) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@183bcda6[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1644443 WARN  (jetty-launcher-8157-thread-2) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@32e46c5d[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1644443 WARN  (jetty-launcher-8157-thread-2) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@32e46c5d[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1644445 INFO  (jetty-launcher-8157-thread-2) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37838/solr
   [junit4]   2> 1644446 INFO  (jetty-launcher-8157-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1644449 INFO  (jetty-launcher-8157-thread-1) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 1644450 WARN  (jetty-launcher-8157-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@6612af6[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1644450 WARN  (jetty-launcher-8157-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@6612af6[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1644453 INFO  (zkConnectionManagerCallback-8169-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1644453 INFO  (jetty-launcher-8157-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1644454 WARN  (jetty-launcher-8157-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@62bd3506[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1644454 WARN  (jetty-launcher-8157-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@62bd3506[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1644455 INFO  (jetty-launcher-8157-thread-1) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37838/solr
   [junit4]   2> 1644456 INFO  (jetty-launcher-8157-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1644463 INFO  (zkConnectionManagerCallback-8175-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1644463 INFO  (jetty-launcher-8157-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1644556 INFO  (jetty-launcher-8157-thread-2) 
[n:127.0.0.1:36887_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 1644562 INFO  (zkConnectionManagerCallback-8177-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1644562 INFO  (jetty-launcher-8157-thread-2) 
[n:127.0.0.1:36887_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 1644656 INFO  (jetty-launcher-8157-thread-1) 
[n:127.0.0.1:39501_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 1644657 INFO  (zkConnectionManagerCallback-8181-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1644657 INFO  (jetty-launcher-8157-thread-1) 
[n:127.0.0.1:39501_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 1644668 INFO  (jetty-launcher-8157-thread-1) 
[n:127.0.0.1:39501_solr     ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:39501_solr
   [junit4]   2> 1644669 INFO  (jetty-launcher-8157-thread-1) 
[n:127.0.0.1:39501_solr     ] o.a.s.c.Overseer Overseer 
(id=72234816305365000-127.0.0.1:39501_solr-n_0000000000) starting
   [junit4]   2> 1644675 INFO  
(OverseerStateUpdate-72234816305365000-127.0.0.1:39501_solr-n_0000000000) 
[n:127.0.0.1:39501_solr     ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:39501_solr
   [junit4]   2> 1644676 INFO  (jetty-launcher-8157-thread-1) 
[n:127.0.0.1:39501_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:39501_solr
   [junit4]   2> 1644677 INFO  
(OverseerStateUpdate-72234816305365000-127.0.0.1:39501_solr-n_0000000000) 
[n:127.0.0.1:39501_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1644679 INFO  (jetty-launcher-8157-thread-1) 
[n:127.0.0.1:39501_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 1644680 WARN  (jetty-launcher-8157-thread-1) 
[n:127.0.0.1:39501_solr     ] o.a.s.c.CoreContainer Not all security plugins 
configured!  authentication=disabled authorization=disabled.  Solr is only as 
secure as you make it. Consider configuring authentication/authorization before 
exposing Solr to users internal or external.  See 
https://s.apache.org/solrsecurity for more info
   [junit4]   2> 1644702 INFO  (jetty-launcher-8157-thread-1) 
[n:127.0.0.1:39501_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1644706 INFO  (jetty-launcher-8157-thread-2) 
[n:127.0.0.1:36887_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1644712 INFO  (jetty-launcher-8157-thread-2) 
[n:127.0.0.1:36887_solr     ] o.a.s.c.ZkController Publish 
node=127.0.0.1:36887_solr as DOWN
   [junit4]   2> 1644714 INFO  (jetty-launcher-8157-thread-2) 
[n:127.0.0.1:36887_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 1644714 INFO  (jetty-launcher-8157-thread-2) 
[n:127.0.0.1:36887_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:36887_solr
   [junit4]   2> 1644715 INFO  (zkCallback-8180-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1644715 INFO  (zkCallback-8176-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1644717 INFO  (jetty-launcher-8157-thread-2) 
[n:127.0.0.1:36887_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 1644717 WARN  (jetty-launcher-8157-thread-2) 
[n:127.0.0.1:36887_solr     ] o.a.s.c.CoreContainer Not all security plugins 
configured!  authentication=disabled authorization=disabled.  Solr is only as 
secure as you make it. Consider configuring authentication/authorization before 
exposing Solr to users internal or external.  See 
https://s.apache.org/solrsecurity for more info
   [junit4]   2> 1644736 INFO  (jetty-launcher-8157-thread-1) 
[n:127.0.0.1:39501_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_39501.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@63407437
   [junit4]   2> 1644738 INFO  (jetty-launcher-8157-thread-2) 
[n:127.0.0.1:36887_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1644750 INFO  (jetty-launcher-8157-thread-1) 
[n:127.0.0.1:39501_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_39501.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@63407437
   [junit4]   2> 1644750 INFO  (jetty-launcher-8157-thread-1) 
[n:127.0.0.1:39501_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_39501.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@63407437
   [junit4]   2> 1644752 INFO  (jetty-launcher-8157-thread-1) 
[n:127.0.0.1:39501_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_A484CB35D215396B-001/tempDir-001/node1/.
   [junit4]   2> 1644769 INFO  (jetty-launcher-8157-thread-2) 
[n:127.0.0.1:36887_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_36887.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@63407437
   [junit4]   2> 1644782 INFO  (jetty-launcher-8157-thread-2) 
[n:127.0.0.1:36887_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_36887.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@63407437
   [junit4]   2> 1644782 INFO  (jetty-launcher-8157-thread-2) 
[n:127.0.0.1:36887_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_36887.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@63407437
   [junit4]   2> 1644784 INFO  (jetty-launcher-8157-thread-2) 
[n:127.0.0.1:36887_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_A484CB35D215396B-001/tempDir-001/node2/.
   [junit4]   2> 1644821 INFO  
(SUITE-AutoScalingHandlerTest-seed#[A484CB35D215396B]-worker) [     ] 
o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2
   [junit4]   2> 1644822 INFO  
(SUITE-AutoScalingHandlerTest-seed#[A484CB35D215396B]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1644823 INFO  (zkConnectionManagerCallback-8192-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1644823 INFO  
(SUITE-AutoScalingHandlerTest-seed#[A484CB35D215396B]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1644825 INFO  
(SUITE-AutoScalingHandlerTest-seed#[A484CB35D215396B]-worker) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 1644826 INFO  
(SUITE-AutoScalingHandlerTest-seed#[A484CB35D215396B]-worker) [     ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:37838/solr ready
   [junit4]   2> 1644851 INFO  
(TEST-AutoScalingHandlerTest.testUpdatePolicy-seed#[A484CB35D215396B]) [     ] 
o.a.s.SolrTestCaseJ4 ###Starting testUpdatePolicy
   [junit4]   2> 1644900 INFO  (qtp1233767943-18317) [n:127.0.0.1:36887_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=1
   [junit4]   2> 1644932 INFO  (qtp1094183483-18312) [n:127.0.0.1:39501_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 1644933 INFO  (qtp1233767943-18313) [n:127.0.0.1:36887_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling 
params={wt=javabin&version=2} status=0 QTime=46
   [junit4]   2> 1644946 INFO  (qtp1094183483-18312) [n:127.0.0.1:39501_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling 
params={wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1644950 INFO  (qtp1233767943-18317) [n:127.0.0.1:36887_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 1644952 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 1644953 INFO  (qtp1233767943-18315) [n:127.0.0.1:36887_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling 
params={wt=javabin&version=2} status=0 QTime=6
   [junit4]   2> 1644954 INFO  (qtp1094183483-18316) [n:127.0.0.1:39501_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling 
params={wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1644955 INFO  
(TEST-AutoScalingHandlerTest.testUpdatePolicy-seed#[A484CB35D215396B]) [     ] 
o.a.s.SolrTestCaseJ4 ###Ending testUpdatePolicy
   [junit4]   2> 1644978 INFO  
(TEST-AutoScalingHandlerTest.testValidation-seed#[A484CB35D215396B]) [     ] 
o.a.s.SolrTestCaseJ4 ###Starting testValidation
   [junit4]   2> 1644982 ERROR (qtp1094183483-18312) [n:127.0.0.1:39501_solr    
 ] o.a.s.h.RequestHandlerBase 
org.apache.solr.api.ApiBag$ExceptionWithErrObject: Error in command payload, 
errors: [{set-trigger={name=node_lost_trigger, event=nodeLost, waitFor=10m, 
enabled=true, foo=bar, actions=[{name=compute_plan, 
class=solr.ComputePlanAction}]}, errorMessages=[Error validating trigger config 
node_lost_trigger: TriggerValidationException{name=node_lost_trigger, 
details='{foo=unknown property}'}]}], 
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.AutoScalingHandler.processOps(AutoScalingHandler.java:241)
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.AutoScalingHandler.handleRequestBody(AutoScalingHandler.java:178)
   [junit4]   2>        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:208)
   [junit4]   2>        at 
org.apache.solr.api.ApiBag$ReqHandlerToApi.call(ApiBag.java:242)
   [junit4]   2>        at 
org.apache.solr.api.V2HttpCall.handleAdmin(V2HttpCall.java:343)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:808)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:559)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:419)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:351)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:166)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:545)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1607)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1297)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:485)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1577)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1212)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
   [junit4]   2>        at 
org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:322)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:717)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
   [junit4]   2>        at 
org.eclipse.jetty.server.Server.handle(Server.java:500)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:383)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:547)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:375)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:270)
   [junit4]   2>        at 
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311)
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103)
   [junit4]   2>        at 
org.eclipse.jetty.io.ssl.SslConnection$DecryptedEndPoint.onFillable(SslConnection.java:543)
   [junit4]   2>        at 
org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:398)
   [junit4]   2>        at 
org.eclipse.jetty.io.ssl.SslConnection$2.succeeded(SslConnection.java:161)
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103)
   [junit4]   2>        at 
org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:117)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:806)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:938)
   [junit4]   2>        at java.base/java.lang.Thread.run(Thread.java:834)
   [junit4]   2> 
   [junit4]   2> 1644982 INFO  (qtp1094183483-18312) [n:127.0.0.1:39501_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling 
params={wt=javabin&version=2} status=400 QTime=3
   [junit4]   2> 1644985 ERROR (qtp1233767943-18313) [n:127.0.0.1:36887_solr    
 ] o.a.s.h.RequestHandlerBase 
org.apache.solr.api.ApiBag$ExceptionWithErrObject: Error in command payload, 
errors: [{set-trigger={name=search_rate_trigger, event=searchRate, waitFor=10m, 
enabled=true, aboveRate=foo, actions=[{name=compute_plan, 
class=solr.ComputePlanAction}]}, errorMessages=[Error validating trigger config 
search_rate_trigger: TriggerValidationException{name=search_rate_trigger, 
details='{aboveRate=Invalid configuration value: 'foo': 
java.lang.NumberFormatException: For input string: "foo"}'}]}], 
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.AutoScalingHandler.processOps(AutoScalingHandler.java:241)
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.AutoScalingHandler.handleRequestBody(AutoScalingHandler.java:178)
   [junit4]   2>        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:208)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:842)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:808)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:559)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:419)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:351)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:166)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:545)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1607)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1297)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:485)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1577)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1212)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
   [junit4]   2>        at 
org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:322)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:717)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
   [junit4]   2>        at 
org.eclipse.jetty.server.Server.handle(Server.java:500)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:383)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:547)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:375)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:270)
   [junit4]   2>        at 
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311)
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103)
   [junit4]   2>        at 
org.eclipse.jetty.io.ssl.SslConnection$DecryptedEndPoint.onFillable(SslConnection.java:543)
   [junit4]   2>        at 
org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:398)
   [junit4]   2>        at 
org.eclipse.jetty.io.ssl.SslConnection$2.succeeded(SslConnection.java:161)
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103)
   [junit4]   2>        at 
org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:117)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:806)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:938)
   [junit4]   2>        at java.base/java.lang.Thread.run(Thread.java:834)
   [junit4]   2> 
   [junit4]   2> 1644985 INFO  (qtp1233767943-18313) [n:127.0.0.1:36887_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling 
params={wt=javabin&version=2} status=400 QTime=1
   [junit4]   2> 1644988 ERROR (qtp1094183483-18314) [n:127.0.0.1:39501_solr    
 ] o.a.s.h.RequestHandlerBase 
org.apache.solr.api.ApiBag$ExceptionWithErrObject: Error in command payload, 
errors: [{set-trigger={name=node_lost_trigger, event=nodeLost, waitFor=10m, 
enabled=true, actions=[{name=compute_plan, foo=bar, 
class=solr.ComputePlanAction}]}, errorMessages=[Error validating trigger config 
node_lost_trigger: TriggerValidationException{name=compute_plan, 
details='{foo=unknown property}'}]}], 
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.AutoScalingHandler.processOps(AutoScalingHandler.java:241)
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.AutoScalingHandler.handleRequestBody(AutoScalingHandler.java:178)
   [junit4]   2>        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:208)
   [junit4]   2>        at 
org.apache.solr.api.ApiBag$ReqHandlerToApi.call(ApiBag.java:242)
   [junit4]   2>        at 
org.apache.solr.api.V2HttpCall.handleAdmin(V2HttpCall.java:343)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:808)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:559)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:419)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:351)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:166)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:545)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1607)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1297)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:485)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1577)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1212)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
   [junit4]   2>        at 
org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:322)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:717)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
   [junit4]   2>        at 
org.eclipse.jetty.server.Server.handle(Server.java:500)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:383)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:547)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:375)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:270)
   [junit4]   2>        at 
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311)
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103)
   [junit4]   2>        at 
org.eclipse.jetty.io.ssl.SslConnection$DecryptedEndPoint.onFillable(SslConnection.java:543)
   [junit4]   2>        at 
org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:398)
   [junit4]   2>        at 
org.eclipse.jetty.io.ssl.SslConnection$2.succeeded(SslConnection.java:161)
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103)
   [junit4]   2>        at 
org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:117)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:806)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:938)
   [junit4]   2>        at java.base/java.lang.Thread.run(Thread.java:834)
   [junit4]   2> 
   [junit4]   2> 1644988 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling 
params={wt=javabin&version=2} status=400 QTime=1
   [junit4]   2> 1645002 INFO  (qtp1233767943-18313) [n:127.0.0.1:36887_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=1
   [junit4]   2> 1645014 INFO  (qtp1094183483-18312) [n:127.0.0.1:39501_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=1
   [junit4]   2> 1645015 INFO  (qtp1094183483-18316) [n:127.0.0.1:39501_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling 
params={wt=javabin&version=2} status=0 QTime=26
   [junit4]   2> 1645020 WARN  (qtp1233767943-18315) [n:127.0.0.1:36887_solr    
 ] o.a.s.c.a.AutoScalingHandler invalid listener configuration
   [junit4]   2>           => TriggerValidationException{name=xyz, 
details='{foo=unknown property}'}
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.TriggerListenerBase.configure(TriggerListenerBase.java:74)
   [junit4]   2> org.apache.solr.cloud.autoscaling.TriggerValidationException: 
null
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.TriggerListenerBase.configure(TriggerListenerBase.java:74)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.HttpTriggerListener.configure(HttpTriggerListener.java:78)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.AutoScalingHandler.handleSetListener(AutoScalingHandler.java:498)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.AutoScalingHandler.processOps(AutoScalingHandler.java:209)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.AutoScalingHandler.handleRequestBody(AutoScalingHandler.java:178)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:208)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.api.ApiBag$ReqHandlerToApi.call(ApiBag.java:242) ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.api.V2HttpCall.handleAdmin(V2HttpCall.java:343) ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:808) 
~[java/:?]
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:559) ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:419)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:351)
 ~[java/:?]
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604)
 ~[jetty-servlet-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:166)
 ~[java/:?]
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604)
 ~[jetty-servlet-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:545) 
~[jetty-servlet-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
 ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1607)
 ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
 ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1297)
 ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188)
 ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:485) 
~[jetty-servlet-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1577)
 ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186)
 ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1212)
 ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) 
~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127) 
~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:322)
 ~[jetty-rewrite-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:717) 
~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127) 
~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.server.Server.handle(Server.java:500) 
~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:383) 
~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:547) 
~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:375) 
~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:270) 
~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311)
 ~[jetty-io-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103) 
~[jetty-io-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.io.ssl.SslConnection$DecryptedEndPoint.onFillable(SslConnection.java:543)
 ~[jetty-io-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:398) 
~[jetty-io-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.io.ssl.SslConnection$2.succeeded(SslConnection.java:161) 
~[jetty-io-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103) 
~[jetty-io-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:117) 
~[jetty-io-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:806)
 ~[jetty-util-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:938)
 ~[jetty-util-9.4.24.v20191120.jar:9.4.24.v20191120]
   [junit4]   2>        at java.lang.Thread.run(Thread.java:834) [?:?]
   [junit4]   2> 1645021 ERROR (qtp1233767943-18315) [n:127.0.0.1:36887_solr    
 ] o.a.s.h.RequestHandlerBase 
org.apache.solr.api.ApiBag$ExceptionWithErrObject: Error in command payload, 
errors: [{set-listener={name=xyz, trigger=node_lost_trigger, stage=[STARTED, 
ABORTED, SUCCEEDED], foo=bar, beforeAction=execute_plan, 
class=org.apache.solr.cloud.autoscaling.HttpTriggerListener, 
url=http://xyz.com/on_node_lost?node={$LOST_NODE_NAME}}, errorMessages=[invalid 
listener configuration: TriggerValidationException{name=xyz, 
details='{foo=unknown property}'}]}], 
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.AutoScalingHandler.processOps(AutoScalingHandler.java:241)
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.AutoScalingHandler.handleRequestBody(AutoScalingHandler.java:178)
   [junit4]   2>        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:208)
   [junit4]   2>        at 
org.apache.solr.api.ApiBag$ReqHandlerToApi.call(ApiBag.java:242)
   [junit4]   2>        at 
org.apache.solr.api.V2HttpCall.handleAdmin(V2HttpCall.java:343)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:808)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:559)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:419)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:351)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:166)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:545)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1607)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1297)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:485)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1577)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1212)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
   [junit4]   2>        at 
org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:322)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:717)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
   [junit4]   2>        at 
org.eclipse.jetty.server.Server.handle(Server.java:500)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:383)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:547)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:375)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:270)
   [junit4]   2>        at 
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311)
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103)
   [junit4]   2>        at 
org.eclipse.jetty.io.ssl.SslConnection$DecryptedEndPoint.onFillable(SslConnection.java:543)
   [junit4]   2>        at 
org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:398)
   [junit4]   2>        at 
org.eclipse.jetty.io.ssl.SslConnection$2.succeeded(SslConnection.java:161)
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103)
   [junit4]   2>        at 
org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:117)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:806)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:938)
   [junit4]   2>        at java.base/java.lang.Thread.run(Thread.java:834)
   [junit4]   2> 
   [junit4]   2> 1645021 INFO  (qtp1233767943-18315) [n:127.0.0.1:36887_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling 
params={wt=javabin&version=2} status=400 QTime=4
   [junit4]   2> 1645022 INFO  
(TEST-AutoScalingHandlerTest.testValidation-seed#[A484CB35D215396B]) [     ] 
o.a.s.SolrTestCaseJ4 ###Ending testValidation
   [junit4]   2> 1645046 INFO  
(TEST-AutoScalingHandlerTest.testErrorHandling-seed#[A484CB35D215396B]) [     ] 
o.a.s.SolrTestCaseJ4 ###Starting testErrorHandling
   [junit4]   2> 1645049 ERROR (qtp1094183483-18314) [n:127.0.0.1:39501_solr    
 ] o.a.s.h.RequestHandlerBase 
org.apache.solr.api.ApiBag$ExceptionWithErrObject: Error in command payload, 
errors: [{set-cluster-policy=[{cores=<10, node=#ANY}, {shard=#EACH, node=#ANY}, 
{nodeRole=overseer, replica=0}], errorMessages=[replica is required in {
   [junit4]   2>   "shard":"#EACH",
   [junit4]   2>   "node":"#ANY"}]}], 
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.AutoScalingHandler.processOps(AutoScalingHandler.java:241)
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.AutoScalingHandler.handleRequestBody(AutoScalingHandler.java:178)
   [junit4]   2>        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:208)
   [junit4]   2>        at 
org.apache.solr.api.ApiBag$ReqHandlerToApi.call(ApiBag.java:242)
   [junit4]   2>        at 
org.apache.solr.api.V2HttpCall.handleAdmin(V2HttpCall.java:343)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:808)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:559)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:419)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:351)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:166)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:545)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1607)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1297)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:485)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1577)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1212)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
   [junit4]   2>        at 
org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:322)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:717)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
   [junit4]   2>        at 
org.eclipse.jetty.server.Server.handle(Server.java:500)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:383)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:547)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:375)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:270)
   [junit4]   2>        at 
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311)
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103)
   [junit4]   2>        at 
org.eclipse.jetty.io.ssl.SslConnection$DecryptedEndPoint.onFillable(SslConnection.java:543)
   [junit4]   2>        at 
org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:398)
   [junit4]   2>        at 
org.eclipse.jetty.io.ssl.SslConnection$2.succeeded(SslConnection.java:161)
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103)
   [junit4]   2>        at 
org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:117)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:806)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:938)
   [junit4]   2>        at java.base/java.lang.Thread.run(Thread.java:834)
   [junit4]   2> 
   [junit4]   2> 1645049 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling 
params={wt=javabin&version=2} status=400 QTime=1
   [junit4]   2> 1645050 INFO  
(TEST-AutoScalingHandlerTest.testErrorHandling-seed#[A484CB35D215396B]) [     ] 
o.a.s.SolrTestCaseJ4 ###Ending testErrorHandling
   [junit4]   2> 1645071 INFO  
(TEST-AutoScalingHandlerTest.testDeleteUsedPolicy-seed#[A484CB35D215396B]) [    
 ] o.a.s.SolrTestCaseJ4 ###Starting testDeleteUsedPolicy
   [junit4]   2> 1645077 INFO  (qtp1233767943-18313) [n:127.0.0.1:36887_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 1645079 INFO  (qtp1094183483-18312) [n:127.0.0.1:39501_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 1645080 INFO  (qtp1233767943-18317) [n:127.0.0.1:36887_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling 
params={wt=javabin&version=2} status=0 QTime=7
   [junit4]   2> 1645081 INFO  (qtp1233767943-18315) [n:127.0.0.1:36887_solr    
 ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
collection.configName=conf&name=COLL1&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2&policy=nodelete
 and sendToOCPQueue=true
   [junit4]   2> 1645087 INFO  
(OverseerThreadFactory-4958-thread-1-processing-n:127.0.0.1:39501_solr) 
[n:127.0.0.1:39501_solr     ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
COLL1
   [junit4]   2> 1645196 INFO  (qtp1233767943-18313) [n:127.0.0.1:36887_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=1
   [junit4]   2> 1645198 INFO  (qtp1094183483-18316) [n:127.0.0.1:39501_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 1645203 INFO  
(OverseerStateUpdate-72234816305365000-127.0.0.1:39501_solr-n_0000000000) 
[n:127.0.0.1:39501_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"COLL1",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"COLL1_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:39501/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1645407 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr    
x:COLL1_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=COLL1_shard1_replica_n1&action=CREATE&numShards=1&collection=COLL1&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1645408 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr    
x:COLL1_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 1646420 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr 
c:COLL1 s:shard1 r:core_node2 x:COLL1_shard1_replica_n1 ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 9.0.0
   [junit4]   2> 1646431 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr 
c:COLL1 s:shard1 r:core_node2 x:COLL1_shard1_replica_n1 ] o.a.s.s.IndexSchema 
[COLL1_shard1_replica_n1] Schema name=minimal
   [junit4]   2> 1646433 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr 
c:COLL1 s:shard1 r:core_node2 x:COLL1_shard1_replica_n1 ] o.a.s.s.IndexSchema 
Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1646433 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr 
c:COLL1 s:shard1 r:core_node2 x:COLL1_shard1_replica_n1 ] o.a.s.c.CoreContainer 
Creating SolrCore 'COLL1_shard1_replica_n1' using configuration from configset 
conf, trusted=true
   [junit4]   2> 1646434 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr 
c:COLL1 s:shard1 r:core_node2 x:COLL1_shard1_replica_n1 ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_39501.solr.core.COLL1.shard1.replica_n1' (registry 
'solr.core.COLL1.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@63407437
   [junit4]   2> 1646434 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr 
c:COLL1 s:shard1 r:core_node2 x:COLL1_shard1_replica_n1 ] o.a.s.c.SolrCore 
[[COLL1_shard1_replica_n1] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_A484CB35D215396B-001/tempDir-001/node1/COLL1_shard1_replica_n1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.AutoScalingHandlerTest_A484CB35D215396B-001/tempDir-001/node1/./COLL1_shard1_replica_n1/data/]
   [junit4]   2> 1646524 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr 
c:COLL1 s:shard1 r:core_node2 x:COLL1_shard1_replica_n1 ] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1646524 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr 
c:COLL1 s:shard1 r:core_node2 x:COLL1_shard1_replica_n1 ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1646527 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr 
c:COLL1 s:shard1 r:core_node2 x:COLL1_shard1_replica_n1 ] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 1646527 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr 
c:COLL1 s:shard1 r:core_node2 x:COLL1_shard1_replica_n1 ] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 1646529 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr 
c:COLL1 s:shard1 r:core_node2 x:COLL1_shard1_replica_n1 ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@146cb8b8[COLL1_shard1_replica_n1] 
main]
   [junit4]   2> 1646531 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr 
c:COLL1 s:shard1 r:core_node2 x:COLL1_shard1_replica_n1 ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 1646532 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr 
c:COLL1 s:shard1 r:core_node2 x:COLL1_shard1_replica_n1 ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 1646532 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr 
c:COLL1 s:shard1 r:core_node2 x:COLL1_shard1_replica_n1 ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1646533 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr 
c:COLL1 s:shard1 r:core_node2 x:COLL1_shard1_replica_n1 ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1657723855585673216
   [junit4]   2> 1646536 INFO  
(searcherExecutor-4967-thread-1-processing-n:127.0.0.1:39501_solr 
x:COLL1_shard1_replica_n1 c:COLL1 s:shard1 r:core_node2) 
[n:127.0.0.1:39501_solr c:COLL1 s:shard1 r:core_node2 x:COLL1_shard1_replica_n1 
] o.a.s.c.SolrCore [COLL1_shard1_replica_n1] Registered new searcher 
Searcher@146cb8b8[COLL1_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1646540 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr 
c:COLL1 s:shard1 r:core_node2 x:COLL1_shard1_replica_n1 ] o.a.s.c.ZkShardTerms 
Successful update of terms at /collections/COLL1/terms/shard1 to 
Terms{values={core_node2=0}, version=0}
   [junit4]   2> 1646540 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr 
c:COLL1 s:shard1 r:core_node2 x:COLL1_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/COLL1/leaders/shard1
   [junit4]   2> 1646544 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr 
c:COLL1 s:shard1 r:core_node2 x:COLL1_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1646544 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr 
c:COLL1 s:shard1 r:core_node2 x:COLL1_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1646544 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr 
c:COLL1 s:shard1 r:core_node2 x:COLL1_shard1_replica_n1 ] o.a.s.c.SyncStrategy 
Sync replicas to https://127.0.0.1:39501/solr/COLL1_shard1_replica_n1/
   [junit4]   2> 1646545 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr 
c:COLL1 s:shard1 r:core_node2 x:COLL1_shard1_replica_n1 ] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 1646545 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr 
c:COLL1 s:shard1 r:core_node2 x:COLL1_shard1_replica_n1 ] o.a.s.c.SyncStrategy 
https://127.0.0.1:39501/solr/COLL1_shard1_replica_n1/ has no replicas
   [junit4]   2> 1646545 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr 
c:COLL1 s:shard1 r:core_node2 x:COLL1_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/COLL1/leaders/shard1/leader after winning as 
/collections/COLL1/leader_elect/shard1/election/72234816305365000-core_node2-n_0000000000
   [junit4]   2> 1646547 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr 
c:COLL1 s:shard1 r:core_node2 x:COLL1_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:39501/solr/COLL1_shard1_replica_n1/ shard1
   [junit4]   2> 1646650 INFO  (zkCallback-8180-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/COLL1/state.json] 
for collection [COLL1] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1646650 INFO  (zkCallback-8180-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/COLL1/state.json] 
for collection [COLL1] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1646651 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr 
c:COLL1 s:shard1 r:core_node2 x:COLL1_shard1_replica_n1 ] o.a.s.c.ZkController 
I am the leader, no recovery necessary
   [junit4]   2> 1646654 INFO  (qtp1094183483-18314) [n:127.0.0.1:39501_solr 
c:COLL1 s:shard1 r:core_node2 x:COLL1_shard1_replica_n1 ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=COLL1_shard1_replica_n1&action=CREATE&numShards=1&collection=COLL1&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1247
   [junit4]   2> 1646656 INFO  (qtp1233767943-18315) [n:127.0.0.1:36887_solr    
 ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at 
most 45 seconds. Check all shard replicas
   [junit4]   2> 1646754 INFO  (zkCallback-8180-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/COLL1/state.json] 
for collection [COLL1] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1646754 INFO  (zkCallback-8180-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/COLL1/state.json] 
for collection [COLL1] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1646754 INFO  (zkCallback-8176-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/COLL1/state.json] 
for collection [COLL1] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1646754 INFO  (zkCallback-8180-thread-3) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/COLL1/state.json] 
for collection [COLL1] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1646755 INFO  (qtp1233767943-18315) [n:127.0.0.1:36887_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={collection.configName=conf&name=COLL1&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2&policy=nodelete}
 status=0 QTime=1673
   [junit4]   2> 1646759 ERROR (qtp1233767943-18317) [n:127.0.0.1:36887_solr    
 ] o.a.s.h.RequestHandlerBase 
org.apache.solr.api.ApiBag$ExceptionWithErrObject: Error in command payload, 
errors: [{remove-policy=nodelete, errorMessages=[policy : nodelete is being 
used by collection COLL1]}], 
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.AutoScalingHandler.processOps(AutoScalingHandler.java:241)
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.AutoScalingHandler.handleRequestBody(AutoScalingHandler.java:178)
   [junit4]   2>        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:208)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:842)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:808)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:559)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:419)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:351)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:166)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:545)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1607)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1297)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:485)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1577)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1212)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
   [junit4]   2>        at 
org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:322)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:717)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
   [junit4]   2>        at 
org.eclipse.jetty.server.Server.handle(Server.java:500)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:383)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:547)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:375)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:270)
   [junit4]   2>        at 
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311)
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103)
   [junit4]   2>        at 
org.eclipse.jetty.io.ssl.SslConnection$DecryptedEndPoint.onFillable(SslConnection.java:543)
   [junit4]   2>        at 
org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:398)
   [junit4]   2>        at 
org.eclipse.jetty.io.ssl.SslConnection$2.succeeded(SslConnection.java:161)
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103)
   [junit4]   2>        at 
org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:117)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:806)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:938)
   [junit4]   2>        at java.base/java.lang.Thread.run(Thread.java:834)
   [junit4]   2> 
   [junit4]   2> 1646759 INFO  (qtp1233767943-18317) [n:127.0.0.1:36887_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling 
params={wt=javabin&version=2} status=400 QTime=2
   [junit4]   2> 1646760 INFO  (qtp1233767943-18313) [n:127.0.0.1:36887_solr    
 ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params 
name=COLL1&action=DELETE&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 1646762 INFO  
(OverseerCollectionConfigSetProcessor-72234816305365000-127.0.0.1:39501_solr-n_0000000000)
 [n:127.0.0.1:39501_solr     ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000000 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 1646763 INFO  
(OverseerThreadFactory-4958-thread-2-processing-n:127.0.0.1:39501_solr) 
[n:127.0.0.1:39501_solr     ] o.a.s.c.a.c.OverseerCollectionMessageHandler 
Executing Collection 
Cmd=action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true&deleteMetricsHistory=true,
 asyncId=null
   [junit4]   2> 1646764 INFO  (qtp1094183483-18312) [n:127.0.0.1:39501_solr    
x:COLL1_shard1_replica_n1 ] o.a.s.m.SolrMetricManager Closing metric reporters 
for registry=solr.core.COLL1.shard1.replica_n1, tag=null
   [junit4]   2> 1646764 INFO  (qtp1094183483-18312) [n:127.0.0.1:39501_solr    
x:COLL1_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@14546443: rootName = 
solr_39501, domain = solr.core.COLL1.shard1.replica_n1, service url = null, 
agent id = null] for registry solr.core.COLL1.shard1.replica_n1 / 
com.codahale.metrics.MetricRegistry@3f5f3f67
   [junit4]   2> 1646793 INFO  (qtp1094183483-18312) [n:127.0.0.1:39501_solr    
x:COLL1_shard1_replica_n1 ] o.a.s.c.SolrCore [COLL1_shard1_replica_n1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@1891e8e5
   [junit4]   2> 1646793 INFO  (qtp1094183483-18312) [n:127.0.0.1:39501_solr    
x:COLL1_shard1_replica_n1 ] o.a.s.m.SolrMetricManager Closing metric reporters 
for registry=solr.core.COLL1.shard1.replica_n1, tag=SolrCore@1891e8e5
   [junit4]   2> 1646793 INFO  (qtp1094183483-18312) [n:127.0.0.1:39501_solr    
x:COLL1_shard1_replica_n1 ] o.a.s.m.SolrMetricManager Closing metric reporters 
for registry=solr.collection.COLL1.shard1.leader, tag=SolrCore@1891e8e5
   [junit4]   2> 1646794 INFO  (qtp1094183483-18312) [n:127.0.0.1:39501_solr    
x:COLL1_shard1_replica_n1 ] o.a.s.u.DirectUpdateHandler2 Committing on 
IndexWriter.close()  ... SKIPPED (unnecessary).
   [junit4]   2> 1646798 INFO  (qtp1094183483-18312) [n:127.0.0.1:39501_solr    
x:COLL1_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/COLL1/terms/shard1 to Terms{values={}, version=1}
   [junit4]   2> 1646799 INFO  (qtp1094183483-18312) [n:127.0.0.1:39501_solr    
x:COLL1_shard1_replica_n1 ] o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/admin/cores 
params={deleteInstanceDir=true&deleteMetricsHistory=true&core=COLL1_shard1_replica_n1&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
 status=0 QTime=35
   [junit4]   2> 1646903 INFO  (zkCallback-8180-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDeleted path:/collections/COLL1/state.json] for 
collection [COLL1] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1646903 INFO  (zkCallback-8180-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDeleted path:/collections/COLL1/state.json] for 
collection [COLL1] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1646903 INFO  (zkCallback-8180-thread-4) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDeleted path:/collections/COLL1/state.json] for 
collection [COLL1] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1646911 INFO  (qtp1233767943-18313) [n:127.0.0.1:36887_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={name=COLL1&action=DELETE&wt=javabin&version=2} status=0 QTime=151
   [junit4]   2> 1646912 INFO  
(TEST-AutoScalingHandlerTest.testDeleteUsedPolicy-seed#[A484CB35D215396B]) [    
 ] o.a.s.SolrTestCaseJ4 ###Ending testDeleteUsedPolicy
   [junit4]   2> 1646934 INFO  
(TEST-AutoScalingHandlerTest.testSuggestionsWithPayload-seed#[A484CB35D215396B])
 [     ] o.a.s.SolrTestCaseJ4 ###Starting testSuggestionsWithPayload
   [junit4]   2> 1646936 INFO  (qtp1233767943-18315) [n:127.0.0.1:36887_solr    
 ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
collection.configName=conf&maxShardsPerNode=4&name=testSuggestionsWithPayload.COLL&nrtReplicas=2&action=CREATE&numShards=1&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1646939 INFO  
(OverseerThreadFactory-4958-thread-3-processing-n:127.0.0.1:39501_solr) 
[n:127.0.0.1:39501_solr     ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
testSuggestionsWithPayload.COLL
   [junit4]   2> 1646940 INFO  
(OverseerCollectionConfigSetProcessor-72234816305365000-127.0.0.1:39501_solr-n_0000000000)
 [n:127.0.0.1:39501_solr     ] 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> 1647152 INFO  
(OverseerStateUpdate-72234816305365000-127.0.0.1:39501_solr-n_0000000000) 
[n:127.0.0.1:39501_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testSuggestionsWithPayload.COLL",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"testSuggestionsWithPayload.COLL_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:36887/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 


[...truncated too long message...]

n1 c:.system s:shard1 r:core_node3) [n:127.0.0.1:46214_solr c:.system s:shard1 
r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Failed to 
get /schema/zkversion from 
http://127.0.0.1:46214/solr/.system_shard1_replica_n2/ due to: 
java.util.concurrent.ExecutionException: 
org.apache.solr.client.solrj.SolrServerException: Server refused connection at: 
http://127.0.0.1:46214/solr/.system_shard1_replica_n2
   [junit4]   2> 3344711 INFO  
(httpUriRequest-61680-thread-1-processing-x:.system_shard1_replica_n1 
r:core_node3 n:127.0.0.1:46214_solr 
http:////127.0.0.1:46214//solr//.system_shard1_replica_n2 c:.system s:shard1) 
[n:127.0.0.1:46214_solr c:.system s:shard1 r:core_node3 
x:.system_shard1_replica_n1 ] o.a.h.i.e.RetryExec I/O exception 
(java.net.SocketException) caught when processing request to 
{}->http://127.0.0.1:46214: Socket closed
   [junit4]   2> 3344711 INFO  
(httpUriRequest-61680-thread-1-processing-x:.system_shard1_replica_n1 
r:core_node3 n:127.0.0.1:46214_solr 
http:////127.0.0.1:46214//solr//.system_shard1_replica_n2 c:.system s:shard1) 
[n:127.0.0.1:46214_solr c:.system s:shard1 r:core_node3 
x:.system_shard1_replica_n1 ] o.a.h.i.e.RetryExec Retrying request to 
{}->http://127.0.0.1:46214
   [junit4]   2> 3344728 WARN  (qtp1989427107-39236) [n:127.0.0.1:46214_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ManagedIndexSchema Core core_node3 was interrupted waiting for schema 
version 2 to propagate to 1 replicas for collection .system
   [junit4]   2> 3344728 INFO  (qtp1989427107-39236) [n:127.0.0.1:46214_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.s.ManagedIndexSchema Took 136500.0ms for 1 replicas to apply schema 
update version 2 for collection .system
   [junit4]   2> 3344728 INFO  (qtp1989427107-39236) [n:127.0.0.1:46214_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.S.Request 
[.system_shard1_replica_n1]  webapp=/solr path=/schema 
params={wt=javabin&version=2} status=0 QTime=136694
   [junit4]   2> 3344729 INFO  (qtp1989427107-39236) [n:127.0.0.1:46214_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] o.a.s.c.SolrCore 
[.system_shard1_replica_n1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@4bc484bd
   [junit4]   2> 3344729 WARN  (qtp1989427107-39236) [n:127.0.0.1:46214_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.m.SolrMetricManager Interrupted while trying to obtain lock to modify 
reporters registry: solr.core..system.shard1.replica_n1
   [junit4]   2> 3344729 INFO  (qtp1989427107-39236) [n:127.0.0.1:46214_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection..system.shard1.leader, tag=SolrCore@4bc484bd
   [junit4]   2> 3344729 INFO  (qtp1989427107-39236) [n:127.0.0.1:46214_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() .
   [junit4]   2> 3344729 INFO  (qtp1989427107-39236) [n:127.0.0.1:46214_solr 
c:.system s:shard1 r:core_node3 x:.system_shard1_replica_n1 ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@36b3df55 commitCommandVersion:0
   [junit4]   2> 3344734 INFO  
(SUITE-SystemCollectionCompatTest-seed#[A484CB35D215396B]-worker) [     ] 
o.a.s.c.ZkTestServer Shutting down ZkTestServer.
   [junit4]   2> 3344938 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/clusterprops.json
   [junit4]   2>        7       /solr/aliases.json
   [junit4]   2>        5       /solr/collections/.system/terms/shard1
   [junit4]   2>        4       /solr/configs/.system/managed-schema
   [junit4]   2>        2       /solr/configs/.system
   [junit4]   2>        2       /solr/packages.json
   [junit4]   2>        2       /solr/security.json
   [junit4]   2>        2       /solr/collections/.system/collectionprops.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        22      /solr/collections/.system/state.json
   [junit4]   2>        7       /solr/clusterstate.json
   [junit4]   2>        6       /solr/aliases.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        26      /solr/overseer/queue
   [junit4]   2>        18      /solr/collections
   [junit4]   2>        13      /solr/overseer/collection-queue-work
   [junit4]   2>        11      /solr/live_nodes
   [junit4]   2> 
   [junit4]   2> 3344940 INFO  
(SUITE-SystemCollectionCompatTest-seed#[A484CB35D215396B]-worker) [     ] 
o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:35739
   [junit4]   2> 3344940 INFO  
(SUITE-SystemCollectionCompatTest-seed#[A484CB35D215396B]-worker) [     ] 
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:35739
   [junit4]   2> 3344940 INFO  
(SUITE-SystemCollectionCompatTest-seed#[A484CB35D215396B]-worker) [     ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1 35739
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.SystemCollectionCompatTest_A484CB35D215396B-001
   [junit4]   2> Feb 05, 2020 7:19:23 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=CheapBastard, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@63ea9d85),
 locale=bn, timezone=W-SU
   [junit4]   2> NOTE: Linux 4.4.0-170-generic amd64/Oracle Corporation 11.0.4 
(64-bit)/cpus=8,threads=1,free=168113416,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [TestUseDocValuesAsStored, 
TestReload, ShardsWhitelistTest, TestLRUStatsCache, 
SimpleCollectionCreateDeleteTest, AddBlockUpdateTest, CurrencyFieldTypeTest, 
MaxSizeAutoCommitTest, TestRandomCollapseQParserPlugin, EnumFieldTest, 
TestTermsQParserPlugin, ShardRoutingCustomTest, DocValuesMissingTest, 
TestRemoteStreaming, TokenizerChainTest, TestFieldCacheVsDocValues, TaggerTest, 
DataDrivenBlockJoinTest, DebugComponentTest, SimplePostToolTest, 
DistributedMLTComponentTest, QueryResultKeyTest, 
TlogReplayBufferedWhileIndexingTest, CollectionReloadTest, TestXmlQParser, 
TestNumericTerms32, TestSolrConfigHandlerCloud, ResponseBuilderTest, 
CdcrBootstrapTest, BitVectorTest, JavaBinAtomicUpdateMultivalueTest, 
ChaosMonkeyNothingIsSafeWithPullReplicasTest, HLLSerializationTest, 
CollectionStateFormat2Test, NumericFieldsTest, TestCopyFieldCollectionResource, 
TestConfigsApi, TestRebalanceLeaders, DistribJoinFromCollectionTest, 
TestDistribDocBasedVersion, TestRuleBasedAuthorizationPlugin, 
HdfsSyncSliceTest, SolrMetricsIntegrationTest, OutputWriterTest, 
TestDynamicFieldNamesIndexCorrectly, TestBlobHandler, 
MetricTriggerIntegrationTest, TestCloudManagedSchema, SolrPluginUtilsTest, 
TestCoreContainer, DistributedFacetExistsSmallTest, CoreAdminOperationTest, 
TestSystemIdResolver, TestExpandComponent, ScheduledTriggerIntegrationTest, 
TestDistribIDF, TestNamedUpdateProcessors, SolrJmxReporterTest, 
FieldAnalysisRequestHandlerTest, DeleteNodeTest, ConvertedLegacyTest, 
TestDocumentBuilder, TestQueryTypes, TestDocSet, MoreLikeThisComponentTest, 
AuthToolTest, RoutingToNodesWithPropertiesTest, 
TestCollectionsAPIViaSolrCloudCluster, TestUniqueKeyFieldResource, 
TestSortByMinMaxFunction, AtomicUpdateProcessorFactoryTest, 
AliasIntegrationTest, TestSweetSpotSimilarityFactory, 
CollectionsAPIDistributedZkTest, TestReplicationHandlerBackup, SliceStateTest, 
TestPhraseSuggestions, LeaderFailureAfterFreshStartTest, 
TestScoreJoinQPNoScore, CreateRoutedAliasTest, BasicAuthIntegrationTest, 
SolrShardReporterTest, RangeFacetCloudTest, TestReplicaProperties, 
ResourceLoaderTest, TestSchemalessBufferedUpdates, 
TestQueryingOnDownCollection, TestLockTree, TestManagedSchemaAPI, 
TriggerCooldownIntegrationTest, TestFoldingMultitermQuery, TestSolrXml, 
BasicDistributedZkTest, JWTVerificationkeyResolverTest, 
TestAtomicUpdateErrorCases, NumberUtilsTest, SolrCoreTest, 
TestSubQueryTransformerCrossCore, RequiredFieldsTest, MetricsHandlerTest, 
RulesTest, TestFieldSortValues, ConfigureRecoveryStrategyTest, 
HdfsRecoverLeaseTest, TestDynamicLoadingUrl, TestSkipOverseerOperations, 
UpdateParamsTest, StatelessScriptUpdateProcessorFactoryTest, 
FullSolrCloudDistribCmdsTest, LoggingHandlerTest, TestGraphMLResponseWriter, 
TestSnapshotCloudManager, TestLazyCores, ExecutePlanActionTest, 
ConjunctionSolrSpellCheckerTest, TestFacetMethods, SynonymTokenizerTest, 
TestInfoStreamLogging, TestSearcherReuse, UniqFieldsUpdateProcessorFactoryTest, 
TestQuerySenderListener, CdcrRequestHandlerTest, 
TestComplexPhraseQParserPlugin, TestConfigSetsAPIZkFailure, 
LeaderElectionIntegrationTest, TestSimDistribStateManager, 
DistributedTermsComponentTest, CheckHdfsIndexTest, MultiThreadedOCPTest, 
ConnectionReuseTest, TestPointFields, SolrXmlInZkTest, TestAnalyzedSuggestions, 
CacheHeaderTest, SearchRateTriggerTest, TestConfigSetImmutable, 
TestSolrCloudWithSecureImpersonation, TestJoin, ScriptEngineTest, 
TestCloudConsistency, MergeStrategyTest, TestFieldTypeResource, 
BJQFilterAccessibleTest, SortSpecParsingTest, FieldMutatingUpdateProcessorTest, 
TestFunctionQuery, DateMathParserTest, TestCodecSupport, 
ConcurrentCreateRoutedAliasTest, ConfigSetsAPITest, DeleteReplicaTest, 
DocValuesNotIndexedTest, HealthCheckHandlerTest, HttpPartitionOnCommitTest, 
LeaderTragicEventTest, LeaderVoteWaitTimeoutTest, MoveReplicaHDFSFailoverTest, 
MoveReplicaHDFSTest, NestedShardedAtomicUpdateTest, OverseerSolrResponseTest, 
OverseerSolrResponseUnsafeSerializationTest, OverseerStatusTest, OverseerTest, 
RecoveryAfterSoftCommitTest, RemoteQueryErrorTest, ReplaceNodeNoTargetTest, 
ReplaceNodeTest, ReplicationFactorTest, SystemCollectionCompatTest]
   [junit4] Completed [531/900 (2!)] on J2 in 140.99s, 1 test, 1 error <<< 
FAILURES!

[...truncated 53666 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to