Build: https://builds.apache.org/job/Lucene-Solr-Tests-7.x/616/

1 tests failed.
FAILED:  
org.apache.solr.cloud.autoscaling.SearchRateTriggerIntegrationTest.testDeleteNode

Error Message:
unexpected DELETENODE status: 
{responseHeader={status=0,QTime=4},status={state=notfound,msg=Did not find 
[search_rate_trigger3/603fd2d64d8858T6qg9p8drulxtpe2mqdfuv8swf/0] in any tasks 
queue}}

Stack Trace:
java.lang.AssertionError: unexpected DELETENODE status: 
{responseHeader={status=0,QTime=4},status={state=notfound,msg=Did not find 
[search_rate_trigger3/603fd2d64d8858T6qg9p8drulxtpe2mqdfuv8swf/0] in any tasks 
queue}}
        at 
__randomizedtesting.SeedInfo.seed([76CF8E654A4312FB:545D40E77D899D86]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at 
org.apache.solr.cloud.autoscaling.SearchRateTriggerIntegrationTest.lambda$testDeleteNode$6(SearchRateTriggerIntegrationTest.java:668)
        at java.util.ArrayList.forEach(ArrayList.java:1257)
        at 
org.apache.solr.cloud.autoscaling.SearchRateTriggerIntegrationTest.testDeleteNode(SearchRateTriggerIntegrationTest.java:660)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        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 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 12985 lines...]
   [junit4] Suite: 
org.apache.solr.cloud.autoscaling.SearchRateTriggerIntegrationTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.SearchRateTriggerIntegrationTest_76CF8E654A4312FB-001/init-core-data-001
   [junit4]   2> 707967 WARN  
(SUITE-SearchRateTriggerIntegrationTest-seed#[76CF8E654A4312FB]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=9 numCloses=9
   [junit4]   2> 707967 INFO  
(SUITE-SearchRateTriggerIntegrationTest-seed#[76CF8E654A4312FB]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 707979 INFO  
(SUITE-SearchRateTriggerIntegrationTest-seed#[76CF8E654A4312FB]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 707979 INFO  
(SUITE-SearchRateTriggerIntegrationTest-seed#[76CF8E654A4312FB]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 707980 INFO  
(SUITE-SearchRateTriggerIntegrationTest-seed#[76CF8E654A4312FB]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 5 servers in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.SearchRateTriggerIntegrationTest_76CF8E654A4312FB-001/tempDir-001
   [junit4]   2> 707980 INFO  
(SUITE-SearchRateTriggerIntegrationTest-seed#[76CF8E654A4312FB]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 708081 INFO  (Thread-1144) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 708081 INFO  (Thread-1144) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 708092 ERROR (Thread-1144) [    ] o.a.z.s.ZooKeeperServer 
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action 
on ERROR or SHUTDOWN server state changes
   [junit4]   2> 708181 INFO  
(SUITE-SearchRateTriggerIntegrationTest-seed#[76CF8E654A4312FB]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:51367
   [junit4]   2> 708183 INFO  (zkConnectionManagerCallback-1445-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 708232 INFO  (jetty-launcher-1442-thread-3) [    ] 
o.e.j.s.Server jetty-9.4.10.v20180503; built: 2018-05-03T15:56:21.710Z; git: 
daa59876e6f384329b122929e70a80934569428c; jvm 1.8.0_172-b11
   [junit4]   2> 708233 INFO  (jetty-launcher-1442-thread-3) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 708233 INFO  (jetty-launcher-1442-thread-3) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 708233 INFO  (jetty-launcher-1442-thread-3) [    ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 708233 INFO  (jetty-launcher-1442-thread-3) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@758fd377{/solr,null,AVAILABLE}
   [junit4]   2> 708237 INFO  (jetty-launcher-1442-thread-4) [    ] 
o.e.j.s.Server jetty-9.4.10.v20180503; built: 2018-05-03T15:56:21.710Z; git: 
daa59876e6f384329b122929e70a80934569428c; jvm 1.8.0_172-b11
   [junit4]   2> 708238 INFO  (jetty-launcher-1442-thread-1) [    ] 
o.e.j.s.Server jetty-9.4.10.v20180503; built: 2018-05-03T15:56:21.710Z; git: 
daa59876e6f384329b122929e70a80934569428c; jvm 1.8.0_172-b11
   [junit4]   2> 708239 INFO  (jetty-launcher-1442-thread-2) [    ] 
o.e.j.s.Server jetty-9.4.10.v20180503; built: 2018-05-03T15:56:21.710Z; git: 
daa59876e6f384329b122929e70a80934569428c; jvm 1.8.0_172-b11
   [junit4]   2> 708241 INFO  (jetty-launcher-1442-thread-4) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 708241 INFO  (jetty-launcher-1442-thread-4) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 708241 INFO  (jetty-launcher-1442-thread-4) [    ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 708241 INFO  (jetty-launcher-1442-thread-4) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@58ceffb{/solr,null,AVAILABLE}
   [junit4]   2> 708243 INFO  (jetty-launcher-1442-thread-1) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 708243 INFO  (jetty-launcher-1442-thread-1) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 708243 INFO  (jetty-launcher-1442-thread-1) [    ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 708243 INFO  (jetty-launcher-1442-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@18e72338{/solr,null,AVAILABLE}
   [junit4]   2> 708256 INFO  (jetty-launcher-1442-thread-5) [    ] 
o.e.j.s.Server jetty-9.4.10.v20180503; built: 2018-05-03T15:56:21.710Z; git: 
daa59876e6f384329b122929e70a80934569428c; jvm 1.8.0_172-b11
   [junit4]   2> 708257 INFO  (jetty-launcher-1442-thread-2) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 708257 INFO  (jetty-launcher-1442-thread-2) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 708257 INFO  (jetty-launcher-1442-thread-2) [    ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 708257 INFO  (jetty-launcher-1442-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@618454e8{/solr,null,AVAILABLE}
   [junit4]   2> 708272 INFO  (jetty-launcher-1442-thread-5) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 708272 INFO  (jetty-launcher-1442-thread-5) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 708272 INFO  (jetty-launcher-1442-thread-5) [    ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 708273 INFO  (jetty-launcher-1442-thread-5) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@10331a18{/solr,null,AVAILABLE}
   [junit4]   2> 708309 INFO  (jetty-launcher-1442-thread-3) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@2345dc82{SSL,[ssl, 
http/1.1]}{127.0.0.1:60421}
   [junit4]   2> 708309 INFO  (jetty-launcher-1442-thread-3) [    ] 
o.e.j.s.Server Started @708364ms
   [junit4]   2> 708309 INFO  (jetty-launcher-1442-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=60421}
   [junit4]   2> 708313 ERROR (jetty-launcher-1442-thread-3) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 708313 INFO  (jetty-launcher-1442-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 708313 INFO  (jetty-launcher-1442-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.4.0
   [junit4]   2> 708313 INFO  (jetty-launcher-1442-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 708313 INFO  (jetty-launcher-1442-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 708313 INFO  (jetty-launcher-1442-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-05-20T18:10:14.310Z
   [junit4]   2> 708339 INFO  (jetty-launcher-1442-thread-5) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@6efd43ec{SSL,[ssl, 
http/1.1]}{127.0.0.1:59986}
   [junit4]   2> 708339 INFO  (jetty-launcher-1442-thread-5) [    ] 
o.e.j.s.Server Started @708394ms
   [junit4]   2> 708339 INFO  (jetty-launcher-1442-thread-5) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=59986}
   [junit4]   2> 708340 INFO  (jetty-launcher-1442-thread-2) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@1135537c{SSL,[ssl, 
http/1.1]}{127.0.0.1:56792}
   [junit4]   2> 708340 INFO  (jetty-launcher-1442-thread-2) [    ] 
o.e.j.s.Server Started @708395ms
   [junit4]   2> 708340 INFO  (jetty-launcher-1442-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=56792}
   [junit4]   2> 708340 INFO  (jetty-launcher-1442-thread-1) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@1bcfc86f{SSL,[ssl, 
http/1.1]}{127.0.0.1:53281}
   [junit4]   2> 708340 INFO  (jetty-launcher-1442-thread-1) [    ] 
o.e.j.s.Server Started @708395ms
   [junit4]   2> 708340 INFO  (jetty-launcher-1442-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=53281}
   [junit4]   2> 708341 INFO  (jetty-launcher-1442-thread-4) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@4820f71a{SSL,[ssl, 
http/1.1]}{127.0.0.1:60740}
   [junit4]   2> 708341 INFO  (jetty-launcher-1442-thread-4) [    ] 
o.e.j.s.Server Started @708396ms
   [junit4]   2> 708341 INFO  (jetty-launcher-1442-thread-4) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=60740}
   [junit4]   2> 708341 ERROR (jetty-launcher-1442-thread-5) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 708341 INFO  (jetty-launcher-1442-thread-5) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 708341 INFO  (jetty-launcher-1442-thread-5) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.4.0
   [junit4]   2> 708341 INFO  (jetty-launcher-1442-thread-5) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 708341 INFO  (jetty-launcher-1442-thread-5) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 708341 INFO  (jetty-launcher-1442-thread-5) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-05-20T18:10:14.338Z
   [junit4]   2> 708342 ERROR (jetty-launcher-1442-thread-4) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 708342 INFO  (jetty-launcher-1442-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 708342 INFO  (jetty-launcher-1442-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.4.0
   [junit4]   2> 708342 INFO  (jetty-launcher-1442-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 708342 INFO  (jetty-launcher-1442-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 708342 INFO  (jetty-launcher-1442-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-05-20T18:10:14.339Z
   [junit4]   2> 708343 ERROR (jetty-launcher-1442-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 708343 INFO  (jetty-launcher-1442-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 708343 INFO  (jetty-launcher-1442-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.4.0
   [junit4]   2> 708343 INFO  (jetty-launcher-1442-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 708343 INFO  (jetty-launcher-1442-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 708343 INFO  (jetty-launcher-1442-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-05-20T18:10:14.340Z
   [junit4]   2> 708343 ERROR (jetty-launcher-1442-thread-2) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 708344 INFO  (jetty-launcher-1442-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 708344 INFO  (jetty-launcher-1442-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.4.0
   [junit4]   2> 708344 INFO  (jetty-launcher-1442-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 708344 INFO  (jetty-launcher-1442-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 708344 INFO  (jetty-launcher-1442-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-05-20T18:10:14.341Z
   [junit4]   2> 708368 INFO  (zkConnectionManagerCallback-1447-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 708368 INFO  (jetty-launcher-1442-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 708375 INFO  (zkConnectionManagerCallback-1455-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 708375 INFO  (jetty-launcher-1442-thread-5) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 708381 INFO  (zkConnectionManagerCallback-1449-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 708382 INFO  (zkConnectionManagerCallback-1451-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 708382 INFO  (jetty-launcher-1442-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 708382 INFO  (jetty-launcher-1442-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 708396 INFO  (zkConnectionManagerCallback-1453-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 708396 INFO  (jetty-launcher-1442-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 708411 INFO  (jetty-launcher-1442-thread-3) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51367/solr
   [junit4]   2> 708413 INFO  (jetty-launcher-1442-thread-4) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51367/solr
   [junit4]   2> 708417 INFO  (jetty-launcher-1442-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51367/solr
   [junit4]   2> 708423 INFO  (zkConnectionManagerCallback-1463-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 708443 INFO  (zkConnectionManagerCallback-1467-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 708454 INFO  (jetty-launcher-1442-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51367/solr
   [junit4]   2> 708531 INFO  (zkConnectionManagerCallback-1459-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 708535 INFO  (zkConnectionManagerCallback-1469-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 708550 INFO  (jetty-launcher-1442-thread-5) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51367/solr
   [junit4]   2> 708590 INFO  (zkConnectionManagerCallback-1473-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 708610 INFO  (zkConnectionManagerCallback-1483-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 708631 INFO  (zkConnectionManagerCallback-1476-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 708647 INFO  (jetty-launcher-1442-thread-1) 
[n:127.0.0.1:53281_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 708676 INFO  (jetty-launcher-1442-thread-1) 
[n:127.0.0.1:53281_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:53281_solr
   [junit4]   2> 708677 INFO  (jetty-launcher-1442-thread-1) 
[n:127.0.0.1:53281_solr    ] o.a.s.c.Overseer Overseer 
(id=73833076418412556-127.0.0.1:53281_solr-n_0000000000) starting
   [junit4]   2> 708679 INFO  (zkConnectionManagerCallback-1478-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 708687 INFO  (zkConnectionManagerCallback-1485-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 708687 INFO  (zkConnectionManagerCallback-1487-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 708720 INFO  (jetty-launcher-1442-thread-5) 
[n:127.0.0.1:59986_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 708721 INFO  (jetty-launcher-1442-thread-2) 
[n:127.0.0.1:56792_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 708724 INFO  (jetty-launcher-1442-thread-3) 
[n:127.0.0.1:60421_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 708724 INFO  (jetty-launcher-1442-thread-2) 
[n:127.0.0.1:56792_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:56792_solr
   [junit4]   2> 708724 INFO  (jetty-launcher-1442-thread-5) 
[n:127.0.0.1:59986_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:59986_solr
   [junit4]   2> 708748 INFO  (jetty-launcher-1442-thread-4) 
[n:127.0.0.1:60740_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 708750 INFO  (jetty-launcher-1442-thread-4) 
[n:127.0.0.1:60740_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 708751 INFO  (zkConnectionManagerCallback-1500-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 708753 INFO  (jetty-launcher-1442-thread-1) 
[n:127.0.0.1:53281_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 708754 INFO  (jetty-launcher-1442-thread-3) 
[n:127.0.0.1:60421_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 708754 INFO  (jetty-launcher-1442-thread-3) 
[n:127.0.0.1:60421_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:60421_solr
   [junit4]   2> 708766 INFO  (jetty-launcher-1442-thread-1) 
[n:127.0.0.1:53281_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:51367/solr ready
   [junit4]   2> 708770 INFO  (zkCallback-1486-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
   [junit4]   2> 708778 INFO  (zkCallback-1475-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
   [junit4]   2> 708787 INFO  (zkCallback-1477-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
   [junit4]   2> 708815 INFO  (jetty-launcher-1442-thread-4) 
[n:127.0.0.1:60740_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 708815 INFO  (jetty-launcher-1442-thread-4) 
[n:127.0.0.1:60740_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:60740_solr
   [junit4]   2> 708815 INFO  (jetty-launcher-1442-thread-1) 
[n:127.0.0.1:53281_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 708815 INFO  (jetty-launcher-1442-thread-1) 
[n:127.0.0.1:53281_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:53281_solr
   [junit4]   2> 708816 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and 
.scheduled_maintenance triggers
   [junit4]   2> 708818 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode 
version 1
   [junit4]   2> 708818 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, 
lastZnodeVersion -1
   [junit4]   2> 708818 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto 
znodeVersion 1
   [junit4]   2> 708835 INFO  (zkCallback-1499-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (5)
   [junit4]   2> 708850 INFO  (zkCallback-1486-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (5)
   [junit4]   2> 708850 INFO  (zkCallback-1477-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (5)
   [junit4]   2> 708851 INFO  (zkCallback-1484-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
   [junit4]   2> 708858 INFO  (zkCallback-1475-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (5)
   [junit4]   2> 708871 INFO  (zkCallback-1468-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (5)
   [junit4]   2> 708897 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial 
livenodes: [127.0.0.1:53281_solr, 127.0.0.1:59986_solr, 127.0.0.1:60421_solr, 
127.0.0.1:56792_solr, 127.0.0.1:60740_solr]
   [junit4]   2> 708909 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 708909 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, 
lastZnodeVersion 1
   [junit4]   2> 708910 DEBUG (ScheduledTrigger-1551-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 5
   [junit4]   2> 709600 INFO  (jetty-launcher-1442-thread-4) 
[n:127.0.0.1:60740_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_60740.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7f92add1
   [junit4]   2> 709665 INFO  (jetty-launcher-1442-thread-1) 
[n:127.0.0.1:53281_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_53281.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7f92add1
   [junit4]   2> 709710 INFO  (jetty-launcher-1442-thread-1) 
[n:127.0.0.1:53281_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_53281.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7f92add1
   [junit4]   2> 709710 INFO  (jetty-launcher-1442-thread-1) 
[n:127.0.0.1:53281_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_53281.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7f92add1
   [junit4]   2> 709711 INFO  (jetty-launcher-1442-thread-1) 
[n:127.0.0.1:53281_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.SearchRateTriggerIntegrationTest_76CF8E654A4312FB-001/tempDir-001/node4/.
   [junit4]   2> 709820 WARN  (jetty-launcher-1442-thread-4) 
[n:127.0.0.1:60740_solr    ] o.a.s.m.r.j.JmxMetricsReporter Unable to register 
gauge
   [junit4]   2> javax.management.InstanceNotFoundException: 
solr_60740:dom1=solr,dom2=jvm,name0=os,name=processCpuTime
   [junit4]   2>        at 
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1095)
 ~[?:1.8.0_172]
   [junit4]   2>        at 
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:427)
 ~[?:1.8.0_172]
   [junit4]   2>        at 
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:415)
 ~[?:1.8.0_172]
   [junit4]   2>        at 
com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:546) 
~[?:1.8.0_172]
   [junit4]   2>        at 
org.apache.solr.metrics.reporters.jmx.JmxMetricsReporter$JmxListener.registerMBean(JmxMetricsReporter.java:530)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.metrics.reporters.jmx.JmxMetricsReporter$JmxListener.onGaugeAdded(JmxMetricsReporter.java:565)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.metrics.reporters.jmx.JmxMetricsReporter.lambda$start$0(JmxMetricsReporter.java:738)
 ~[java/:?]
   [junit4]   2>        at java.util.HashMap.forEach(HashMap.java:1289) 
~[?:1.8.0_172]
   [junit4]   2>        at 
org.apache.solr.metrics.reporters.jmx.JmxMetricsReporter.start(JmxMetricsReporter.java:728)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.metrics.reporters.SolrJmxReporter.doInit(SolrJmxReporter.java:110)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.metrics.SolrMetricReporter.init(SolrMetricReporter.java:70) 
~[java/:?]
   [junit4]   2>        at 
org.apache.solr.metrics.SolrMetricManager.loadReporter(SolrMetricManager.java:930)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.metrics.SolrMetricManager.loadReporters(SolrMetricManager.java:866)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.load(CoreContainer.java:549) ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.createCoreContainer(SolrDispatchFilter.java:268)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.init(SolrDispatchFilter.java:188) 
~[java/:?]
   [junit4]   2>        at 
org.eclipse.jetty.servlet.FilterHolder.initialize(FilterHolder.java:139) 
~[jetty-servlet-9.4.10.v20180503.jar:9.4.10.v20180503]
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.initialize(ServletHandler.java:741) 
~[jetty-servlet-9.4.10.v20180503.jar:9.4.10.v20180503]
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.updateMappings(ServletHandler.java:1477)
 ~[jetty-servlet-9.4.10.v20180503.jar:9.4.10.v20180503]
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.setFilterMappings(ServletHandler.java:1542)
 ~[jetty-servlet-9.4.10.v20180503.jar:9.4.10.v20180503]
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.addFilterMapping(ServletHandler.java:1186)
 ~[jetty-servlet-9.4.10.v20180503.jar:9.4.10.v20180503]
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.addFilterWithMapping(ServletHandler.java:1023)
 ~[jetty-servlet-9.4.10.v20180503.jar:9.4.10.v20180503]
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletContextHandler.addFilter(ServletContextHandler.java:473)
 ~[jetty-servlet-9.4.10.v20180503.jar:9.4.10.v20180503]
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner$1.lifeCycleStarted(JettySolrRunner.java:308)
 ~[java/:?]
   [junit4]   2>        at 
org.eclipse.jetty.util.component.AbstractLifeCycle.setStarted(AbstractLifeCycle.java:179)
 ~[jetty-util-9.4.10.v20180503.jar:9.4.10.v20180503]
   [junit4]   2>        at 
org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:69)
 ~[jetty-util-9.4.10.v20180503.jar:9.4.10.v20180503]
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner.start(JettySolrRunner.java:396)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner.start(JettySolrRunner.java:369)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.MiniSolrCloudCluster.startJettySolrRunner(MiniSolrCloudCluster.java:392)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.cloud.MiniSolrCloudCluster.lambda$new$0(MiniSolrCloudCluster.java:248)
 ~[java/:?]
   [junit4]   2>        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266) ~[?:1.8.0_172]
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:192)
 ~[java/:?]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) 
[?:1.8.0_172]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) 
[?:1.8.0_172]
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748) [?:1.8.0_172]
   [junit4]   2> 709876 INFO  (jetty-launcher-1442-thread-5) 
[n:127.0.0.1:59986_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_59986.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7f92add1
   [junit4]   2> 709888 INFO  (jetty-launcher-1442-thread-2) 
[n:127.0.0.1:56792_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_56792.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7f92add1
   [junit4]   2> 709901 INFO  (jetty-launcher-1442-thread-4) 
[n:127.0.0.1:60740_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_60740.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7f92add1
   [junit4]   2> 709901 INFO  (jetty-launcher-1442-thread-4) 
[n:127.0.0.1:60740_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_60740.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7f92add1
   [junit4]   2> 709910 INFO  (jetty-launcher-1442-thread-4) 
[n:127.0.0.1:60740_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.SearchRateTriggerIntegrationTest_76CF8E654A4312FB-001/tempDir-001/node3/.
   [junit4]   2> 709933 DEBUG (ScheduledTrigger-1551-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 5
   [junit4]   2> 709939 INFO  (jetty-launcher-1442-thread-2) 
[n:127.0.0.1:56792_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_56792.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7f92add1
   [junit4]   2> 709939 INFO  (jetty-launcher-1442-thread-2) 
[n:127.0.0.1:56792_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_56792.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7f92add1
   [junit4]   2> 709941 INFO  (jetty-launcher-1442-thread-5) 
[n:127.0.0.1:59986_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_59986.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7f92add1
   [junit4]   2> 709941 INFO  (jetty-launcher-1442-thread-5) 
[n:127.0.0.1:59986_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_59986.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7f92add1
   [junit4]   2> 709971 INFO  (jetty-launcher-1442-thread-2) 
[n:127.0.0.1:56792_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.SearchRateTriggerIntegrationTest_76CF8E654A4312FB-001/tempDir-001/node1/.
   [junit4]   2> 709971 INFO  (jetty-launcher-1442-thread-5) 
[n:127.0.0.1:59986_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.SearchRateTriggerIntegrationTest_76CF8E654A4312FB-001/tempDir-001/node5/.
   [junit4]   2> 710158 INFO  (zkConnectionManagerCallback-1505-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 710159 INFO  (jetty-launcher-1442-thread-4) 
[n:127.0.0.1:60740_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (5)
   [junit4]   2> 710160 INFO  (jetty-launcher-1442-thread-4) 
[n:127.0.0.1:60740_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:51367/solr ready
   [junit4]   2> 710199 INFO  (zkConnectionManagerCallback-1511-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 710200 INFO  (jetty-launcher-1442-thread-5) 
[n:127.0.0.1:59986_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (5)
   [junit4]   2> 710201 INFO  (jetty-launcher-1442-thread-5) 
[n:127.0.0.1:59986_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:51367/solr ready
   [junit4]   2> 710211 INFO  (zkConnectionManagerCallback-1515-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 710212 INFO  (jetty-launcher-1442-thread-2) 
[n:127.0.0.1:56792_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (5)
   [junit4]   2> 710213 INFO  (jetty-launcher-1442-thread-2) 
[n:127.0.0.1:56792_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:51367/solr ready
   [junit4]   2> 710294 INFO  (jetty-launcher-1442-thread-3) 
[n:127.0.0.1:60421_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_60421.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7f92add1
   [junit4]   2> 710324 INFO  (jetty-launcher-1442-thread-3) 
[n:127.0.0.1:60421_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_60421.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7f92add1
   [junit4]   2> 710325 INFO  (jetty-launcher-1442-thread-3) 
[n:127.0.0.1:60421_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_60421.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7f92add1
   [junit4]   2> 710326 INFO  (jetty-launcher-1442-thread-3) 
[n:127.0.0.1:60421_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.SearchRateTriggerIntegrationTest_76CF8E654A4312FB-001/tempDir-001/node2/.
   [junit4]   2> 710386 INFO  (zkConnectionManagerCallback-1520-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 710387 INFO  (jetty-launcher-1442-thread-3) 
[n:127.0.0.1:60421_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (5)
   [junit4]   2> 710388 INFO  (jetty-launcher-1442-thread-3) 
[n:127.0.0.1:60421_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:51367/solr ready
   [junit4]   2> 710526 INFO  (zkConnectionManagerCallback-1522-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 710558 INFO  (zkConnectionManagerCallback-1527-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 710559 INFO  
(SUITE-SearchRateTriggerIntegrationTest-seed#[76CF8E654A4312FB]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
   [junit4]   2> 710560 INFO  
(SUITE-SearchRateTriggerIntegrationTest-seed#[76CF8E654A4312FB]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:51367/solr ready
   [junit4]   2> 710922 INFO  (qtp1173905842-4756) [n:127.0.0.1:60421_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=32
   [junit4]   2> 710974 DEBUG (ScheduledTrigger-1551-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 5
   [junit4]   2> 710987 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_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> 711265 INFO  (qtp145610257-4781) [n:127.0.0.1:56792_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> 711324 INFO  (qtp1322072216-4792) [n:127.0.0.1:59986_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> 711384 INFO  (qtp1213582878-4763) [n:127.0.0.1:60740_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> 711386 DEBUG (qtp1173905842-4753) [n:127.0.0.1:60421_solr    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 711387 DEBUG (zkCallback-1499-thread-1) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
2
   [junit4]   2> 711388 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto 
znodeVersion 2
   [junit4]   2> 711390 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 711391 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, 
lastZnodeVersion 2
   [junit4]   2> 711396 INFO  (qtp1173905842-4753) [n:127.0.0.1:60421_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling 
params={wt=javabin&version=2} status=0 QTime=560
   [junit4]   2> 711493 INFO  
(TEST-SearchRateTriggerIntegrationTest.testAboveSearchRate-seed#[76CF8E654A4312FB])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testAboveSearchRate
   [junit4]   2> 711494 INFO  
(TEST-SearchRateTriggerIntegrationTest.testAboveSearchRate-seed#[76CF8E654A4312FB])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
   [junit4]   2> 711502 INFO  
(TEST-SearchRateTriggerIntegrationTest.testAboveSearchRate-seed#[76CF8E654A4312FB])
 [    ] o.a.s.c.a.SearchRateTriggerIntegrationTest /autoscaling.json reset, new 
znode version 3
   [junit4]   2> 711506 DEBUG (zkCallback-1499-thread-1) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
3
   [junit4]   2> 711506 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto 
znodeVersion 3
   [junit4]   2> 711508 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
   [junit4]   2> 711508 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 711509 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3, 
lastZnodeVersion 3
   [junit4]   2> 716511 INFO  (qtp1173905842-4755) [n:127.0.0.1:60421_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=2&collection.configName=conf&name=aboveRate_collection&nrtReplicas=2&action=CREATE&numShards=1&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 716514 INFO  (OverseerThreadFactory-1553-thread-1) [    ] 
o.a.s.c.a.c.CreateCollectionCmd Create collection aboveRate_collection
   [junit4]   2> 716636 INFO  
(OverseerStateUpdate-73833076418412556-127.0.0.1:53281_solr-n_0000000000) [    
] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"aboveRate_collection",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"aboveRate_collection_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:56792/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 716638 INFO  
(OverseerStateUpdate-73833076418412556-127.0.0.1:53281_solr-n_0000000000) [    
] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"aboveRate_collection",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"aboveRate_collection_shard1_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:53281/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 716889 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr    
x:aboveRate_collection_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core 
create command 
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=aboveRate_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=aboveRate_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 716890 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr    
x:aboveRate_collection_shard1_replica_n1] o.a.s.c.TransientSolrCoreCacheDefault 
Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 716891 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr    
x:aboveRate_collection_shard1_replica_n2] o.a.s.h.a.CoreAdminOperation core 
create command 
qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=aboveRate_collection_shard1_replica_n2&action=CREATE&numShards=1&collection=aboveRate_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 717933 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene 
MatchVersion: 7.4.0
   [junit4]   2> 717944 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.SolrConfig Using Lucene 
MatchVersion: 7.4.0
   [junit4]   2> 717959 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.s.IndexSchema 
[aboveRate_collection_shard1_replica_n1] Schema name=minimal
   [junit4]   2> 717978 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.s.IndexSchema 
[aboveRate_collection_shard1_replica_n2] Schema name=minimal
   [junit4]   2> 717983 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema 
minimal/1.1 with uniqueid field id
   [junit4]   2> 717983 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.c.CoreContainer Creating 
SolrCore 'aboveRate_collection_shard1_replica_n1' using configuration from 
collection aboveRate_collection, trusted=true
   [junit4]   2> 717984 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX 
monitoring for 'solr_56792.solr.core.aboveRate_collection.shard1.replica_n1' 
(registry 'solr.core.aboveRate_collection.shard1.replica_n1') enabled at 
server: com.sun.jmx.mbeanserver.JmxMBeanServer@7f92add1
   [junit4]   2> 717984 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 717984 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.c.SolrCore 
[[aboveRate_collection_shard1_replica_n1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.SearchRateTriggerIntegrationTest_76CF8E654A4312FB-001/tempDir-001/node1/aboveRate_collection_shard1_replica_n1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.SearchRateTriggerIntegrationTest_76CF8E654A4312FB-001/tempDir-001/node1/./aboveRate_collection_shard1_replica_n1/data/]
   [junit4]   2> 717986 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.s.IndexSchema Loaded schema 
minimal/1.1 with uniqueid field id
   [junit4]   2> 717986 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.CoreContainer Creating 
SolrCore 'aboveRate_collection_shard1_replica_n2' using configuration from 
collection aboveRate_collection, trusted=true
   [junit4]   2> 717986 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.m.r.SolrJmxReporter JMX 
monitoring for 'solr_53281.solr.core.aboveRate_collection.shard1.replica_n2' 
(registry 'solr.core.aboveRate_collection.shard1.replica_n2') enabled at 
server: com.sun.jmx.mbeanserver.JmxMBeanServer@7f92add1
   [junit4]   2> 717986 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 717986 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.SolrCore 
[[aboveRate_collection_shard1_replica_n2] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.SearchRateTriggerIntegrationTest_76CF8E654A4312FB-001/tempDir-001/node4/aboveRate_collection_shard1_replica_n2],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.SearchRateTriggerIntegrationTest_76CF8E654A4312FB-001/tempDir-001/node4/./aboveRate_collection_shard1_replica_n2/data/]
   [junit4]   2> 718209 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.u.UpdateHandler Using UpdateLog 
implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 718209 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.u.UpdateLog Initializing 
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 718211 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 718211 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 718213 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@5dcefafe[aboveRate_collection_shard1_replica_n2] main]
   [junit4]   2> 718215 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.r.ManagedResourceStorage 
Configured ZooKeeperStorageIO with znodeBase: /configs/conf
   [junit4]   2> 718216 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.r.ManagedResourceStorage Loaded 
null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 718217 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.h.ReplicationHandler Commits 
will be reserved for 10000ms.
   [junit4]   2> 718220 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog 
implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 718220 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.u.UpdateLog Initializing 
UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 718222 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 718222 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 718223 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.u.UpdateLog Could not find max 
version in index or recent updates, using new clock 1601007595521310720
   [junit4]   2> 718226 INFO  
(searcherExecutor-1565-thread-1-processing-n:127.0.0.1:53281_solr 
x:aboveRate_collection_shard1_replica_n2 c:aboveRate_collection s:shard1 
r:core_node4) [n:127.0.0.1:53281_solr c:aboveRate_collection s:shard1 
r:core_node4 x:aboveRate_collection_shard1_replica_n2] o.a.s.c.SolrCore 
[aboveRate_collection_shard1_replica_n2] Registered new searcher 
Searcher@5dcefafe[aboveRate_collection_shard1_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 718234 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.ZkShardTerms Successful 
update of terms at /collections/aboveRate_collection/terms/shard1 to 
Terms{values={core_node4=0}, version=0}
   [junit4]   2> 718240 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContext 
Waiting until we see more replicas up for shard shard1: total=2 found=1 
timeoutin=9999ms
   [junit4]   2> 718240 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@17dfe1bb[aboveRate_collection_shard1_replica_n1] main]
   [junit4]   2> 718242 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.r.ManagedResourceStorage 
Configured ZooKeeperStorageIO with znodeBase: /configs/conf
   [junit4]   2> 718242 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded 
null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 718243 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits 
will be reserved for 10000ms.
   [junit4]   2> 718244 INFO  
(searcherExecutor-1564-thread-1-processing-n:127.0.0.1:56792_solr 
x:aboveRate_collection_shard1_replica_n1 c:aboveRate_collection s:shard1 
r:core_node3) [n:127.0.0.1:56792_solr c:aboveRate_collection s:shard1 
r:core_node3 x:aboveRate_collection_shard1_replica_n1] o.a.s.c.SolrCore 
[aboveRate_collection_shard1_replica_n1] Registered new searcher 
Searcher@17dfe1bb[aboveRate_collection_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 718258 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max 
version in index or recent updates, using new clock 1601007595558010880
   [junit4]   2> 718272 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.c.ZkShardTerms Successful 
update of terms at /collections/aboveRate_collection/terms/shard1 to 
Terms{values={core_node3=0, core_node4=0}, version=1}
   [junit4]   2> 718741 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContext 
Enough replicas found to continue.
   [junit4]   2> 718741 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContext I 
may be the new leader - try and sync
   [junit4]   2> 718741 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.SyncStrategy Sync replicas to 
https://127.0.0.1:53281/solr/aboveRate_collection_shard1_replica_n2/
   [junit4]   2> 718742 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.u.PeerSync PeerSync: 
core=aboveRate_collection_shard1_replica_n2 url=https://127.0.0.1:53281/solr 
START 
replicas=[https://127.0.0.1:56792/solr/aboveRate_collection_shard1_replica_n1/] 
nUpdates=100
   [junit4]   2> 718768 INFO  (qtp145610257-4779) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n1]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 719050 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.u.PeerSync PeerSync: 
core=aboveRate_collection_shard1_replica_n2 url=https://127.0.0.1:53281/solr 
DONE.  We have no versions.  sync failed.
   [junit4]   2> 719050 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.SyncStrategy Leader's attempt 
to sync with shard failed, moving to the next candidate
   [junit4]   2> 719050 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContext We 
failed sync, but we have no versions - we can't sync in that case - we were 
active before, so become leader anyway
   [junit4]   2> 719050 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContext 
Found all replicas participating in election, clear LIR
   [junit4]   2> 719054 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContext I 
am the new leader: 
https://127.0.0.1:53281/solr/aboveRate_collection_shard1_replica_n2/ shard1
   [junit4]   2> 719158 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.ZkController I am the leader, 
no recovery necessary
   [junit4]   2> 719161 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.s.HttpSolrCall [admin] 
webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=aboveRate_collection_shard1_replica_n2&action=CREATE&numShards=1&collection=aboveRate_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=2270
   [junit4]   2> 719261 INFO  (zkCallback-1475-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/aboveRate_collection/state.json] for collection 
[aboveRate_collection] has occurred - updating... (live nodes size: [5])
   [junit4]   2> 719279 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] 
webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=aboveRate_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=aboveRate_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=2389
   [junit4]   2> 719292 INFO  (qtp1173905842-4755) [n:127.0.0.1:60421_solr    ] 
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 719381 INFO  (zkCallback-1484-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/aboveRate_collection/state.json] for collection 
[aboveRate_collection] has occurred - updating... (live nodes size: [5])
   [junit4]   2> 719381 INFO  (zkCallback-1475-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/aboveRate_collection/state.json] for collection 
[aboveRate_collection] has occurred - updating... (live nodes size: [5])
   [junit4]   2> 720293 INFO  (qtp1173905842-4755) [n:127.0.0.1:60421_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={replicationFactor=2&collection.configName=conf&name=aboveRate_collection&nrtReplicas=2&action=CREATE&numShards=1&wt=javabin&version=2}
 status=0 QTime=3782
   [junit4]   2> 720345 INFO  (qtp1173905842-4752) [n:127.0.0.1:60421_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> 720351 INFO  (qtp613516905-4774) [n:127.0.0.1:53281_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={wt=javabin&version=2&key=solr.core.aboveRate_collection.shard1.replica_n2:INDEX.sizeInBytes}
 status=0 QTime=1
   [junit4]   2> 720354 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_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> 720362 INFO  (qtp145610257-4782) [n:127.0.0.1:56792_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={wt=javabin&version=2&key=solr.core.aboveRate_collection.shard1.replica_n1:INDEX.sizeInBytes}
 status=0 QTime=3
   [junit4]   2> 720364 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_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> 720368 INFO  (qtp1322072216-4787) [n:127.0.0.1:59986_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> 720380 INFO  (qtp1213582878-4759) [n:127.0.0.1:60740_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> 720381 DEBUG (qtp1173905842-4753) [n:127.0.0.1:60421_solr    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 720382 DEBUG (zkCallback-1499-thread-1) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
4
   [junit4]   2> 720383 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto 
znodeVersion 4
   [junit4]   2> 720383 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
   [junit4]   2> 720383 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 720383 INFO  (qtp1173905842-4753) [n:127.0.0.1:60421_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling 
params={wt=javabin&version=2} status=0 QTime=81
   [junit4]   2> 720384 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 4, 
lastZnodeVersion 4
   [junit4]   2> 720391 INFO  (qtp1173905842-4752) [n:127.0.0.1:60421_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> 720396 INFO  (qtp613516905-4774) [n:127.0.0.1:53281_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={wt=javabin&version=2&key=solr.core.aboveRate_collection.shard1.replica_n2:INDEX.sizeInBytes}
 status=0 QTime=2
   [junit4]   2> 720402 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_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> 720411 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={wt=javabin&version=2&key=solr.core.aboveRate_collection.shard1.replica_n1:INDEX.sizeInBytes}
 status=0 QTime=0
   [junit4]   2> 720413 INFO  (qtp145610257-4782) [n:127.0.0.1:56792_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> 720416 INFO  (qtp1322072216-4791) [n:127.0.0.1:59986_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> 720436 INFO  (qtp1213582878-4762) [n:127.0.0.1:60740_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> 720438 DEBUG (qtp1173905842-4755) [n:127.0.0.1:60421_solr    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 720439 DEBUG (zkCallback-1499-thread-1) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
5
   [junit4]   2> 720439 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto 
znodeVersion 5
   [junit4]   2> 720439 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
   [junit4]   2> 720440 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 720440 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 5, 
lastZnodeVersion 5
   [junit4]   2> 720440 INFO  (qtp1173905842-4755) [n:127.0.0.1:60421_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling 
params={wt=javabin&version=2} status=0 QTime=54
   [junit4]   2> 720445 INFO  (qtp1173905842-4756) [n:127.0.0.1:60421_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> 720446 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={wt=javabin&version=2&key=solr.core.aboveRate_collection.shard1.replica_n2:INDEX.sizeInBytes}
 status=0 QTime=0
   [junit4]   2> 720448 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_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> 720449 INFO  (qtp145610257-4782) [n:127.0.0.1:56792_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={wt=javabin&version=2&key=solr.core.aboveRate_collection.shard1.replica_n1:INDEX.sizeInBytes}
 status=0 QTime=0
   [junit4]   2> 720451 INFO  (qtp145610257-4782) [n:127.0.0.1:56792_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> 720452 INFO  (qtp1322072216-4787) [n:127.0.0.1:59986_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> 720454 INFO  (qtp1213582878-4764) [n:127.0.0.1:60740_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> 720454 DEBUG (qtp1173905842-4753) [n:127.0.0.1:60421_solr    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 720455 INFO  (qtp1173905842-4753) [n:127.0.0.1:60421_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling 
params={wt=javabin&version=2} status=0 QTime=13
   [junit4]   2> 720455 DEBUG (zkCallback-1499-thread-1) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
6
   [junit4]   2> 720456 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto 
znodeVersion 6
   [junit4]   2> 720456 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
   [junit4]   2> 720459 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 720460 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 6, 
lastZnodeVersion 6
   [junit4]   2> 720491 INFO  (qtp1173905842-4755) [n:127.0.0.1:60421_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> 720505 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={wt=javabin&version=2&key=solr.core.aboveRate_collection.shard1.replica_n2:INDEX.sizeInBytes}
 status=0 QTime=0
   [junit4]   2> 720507 INFO  (qtp613516905-4772) [n:127.0.0.1:53281_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> 720522 INFO  (qtp145610257-4783) [n:127.0.0.1:56792_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={wt=javabin&version=2&key=solr.core.aboveRate_collection.shard1.replica_n1:INDEX.sizeInBytes}
 status=0 QTime=0
   [junit4]   2> 720525 INFO  (qtp145610257-4783) [n:127.0.0.1:56792_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> 720542 INFO  (qtp1322072216-4789) [n:127.0.0.1:59986_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> 720570 INFO  (qtp1213582878-4764) [n:127.0.0.1:60740_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> 720571 DEBUG (qtp1213582878-4762) [n:127.0.0.1:60740_solr    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 720572 INFO  (qtp1213582878-4762) [n:127.0.0.1:60740_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling 
params={wt=javabin&version=2} status=0 QTime=95
   [junit4]   2> 720572 DEBUG (zkCallback-1499-thread-1) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
7
   [junit4]   2> 720573 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto 
znodeVersion 7
   [junit4]   2> 720573 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
   [junit4]   2> 720573 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 720581 DEBUG 
(OverseerAutoScalingTriggerThread-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 7, 
lastZnodeVersion 7
   [junit4]   2> 720583 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n1]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720584 INFO  (qtp145610257-4782) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n1]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720635 INFO  (qtp613516905-4774) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n2]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720636 INFO  (qtp613516905-4775) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n2]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720637 INFO  (qtp145610257-4782) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n1]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720638 INFO  
(OverseerCollectionConfigSetProcessor-73833076418412556-127.0.0.1:53281_solr-n_0000000000)
 [    ] 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> 720639 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n1]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720640 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n1]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720641 INFO  (qtp613516905-4775) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n2]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720642 INFO  (qtp613516905-4774) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n2]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720643 INFO  (qtp613516905-4774) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n2]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720644 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n1]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720645 INFO  (qtp613516905-4774) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n2]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720647 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n1]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720648 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n1]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720649 INFO  (qtp613516905-4774) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n2]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720650 INFO  (qtp613516905-4774) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n2]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720652 INFO  (qtp613516905-4774) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n2]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720653 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n1]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720654 INFO  (qtp145610257-4780) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n1]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720655 INFO  (qtp613516905-4775) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n2]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720657 INFO  (qtp613516905-4775) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n2]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720658 INFO  (qtp145610257-4782) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n1]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720660 INFO  (qtp613516905-4775) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n2]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720661 INFO  (qtp145610257-4782) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n1]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720662 INFO  (qtp145610257-4782) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n1]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720663 INFO  (qtp613516905-4775) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n2]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720664 INFO  (qtp613516905-4775) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n2]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720667 INFO  (qtp613516905-4775) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n2]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720687 INFO  (qtp613516905-4774) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n2]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720689 INFO  (qtp613516905-4775) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n2]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720691 INFO  (qtp145610257-4782) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n1]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720692 INFO  (qtp145610257-4782) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n1]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720693 INFO  (qtp613516905-4775) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n2]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720694 INFO  (qtp145610257-4782) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n1]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720703 INFO  (qtp613516905-4775) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n2]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720704 INFO  (qtp613516905-4775) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n2]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720705 INFO  (qtp613516905-4775) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n2]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720706 INFO  (qtp145610257-4782) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n1]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720710 INFO  (qtp145610257-4782) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n1]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720711 INFO  (qtp613516905-4775) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n2]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720713 INFO  (qtp145610257-4782) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n1]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720716 INFO  (qtp613516905-4774) [n:127.0.0.1:53281_solr 
c:aboveRate_collection s:shard1 r:core_node4 
x:aboveRate_collection_shard1_replica_n2] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n2]  webapp=/solr path=/select 
params={q=*:*&_stateVer_=aboveRate_collection:6&wt=javabin&version=2} hits=0 
status=0 QTime=0
   [junit4]   2> 720717 INFO  (qtp145610257-4782) [n:127.0.0.1:56792_solr 
c:aboveRate_collection s:shard1 r:core_node3 
x:aboveRate_collection_shard1_replica_n1] o.a.s.c.S.Request 
[aboveRate_collection_shard1_replica_n1]  webapp=/solr path=/select param

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

gure:
[ivy:configure] :: loading settings :: file = 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml

resolve:

jar-checksums:
    [mkdir] Created dir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/null1159699024
     [copy] Copying 39 files to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/null1159699024
   [delete] Deleting directory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/null1159699024

resolve-example:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml

resolve:

resolve-server:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml

resolve:

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml

resolve:

ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.

-ivy-fail-disallowed-ivy-version:

ivy-fail:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml

resolve:

jar-checksums:
    [mkdir] Created dir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/null1403981373
     [copy] Copying 246 files to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/null1403981373
   [delete] Deleting directory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/null1403981373

check-working-copy:
[ivy:cachepath] :: resolving dependencies :: 
org.eclipse.jgit#org.eclipse.jgit-caller;working
[ivy:cachepath]         confs: [default]
[ivy:cachepath]         found 
org.eclipse.jgit#org.eclipse.jgit;4.6.0.201612231935-r in public
[ivy:cachepath]         found com.jcraft#jsch;0.1.53 in public
[ivy:cachepath]         found com.googlecode.javaewah#JavaEWAH;1.1.6 in public
[ivy:cachepath]         found org.apache.httpcomponents#httpclient;4.3.6 in 
public
[ivy:cachepath]         found org.apache.httpcomponents#httpcore;4.3.3 in public
[ivy:cachepath]         found commons-logging#commons-logging;1.1.3 in public
[ivy:cachepath]         found commons-codec#commons-codec;1.6 in public
[ivy:cachepath]         found org.slf4j#slf4j-api;1.7.2 in public
[ivy:cachepath] :: resolution report :: resolve 202ms :: artifacts dl 4ms
        ---------------------------------------------------------------------
        |                  |            modules            ||   artifacts   |
        |       conf       | number| search|dwnlded|evicted|| number|dwnlded|
        ---------------------------------------------------------------------
        |      default     |   8   |   0   |   0   |   0   ||   8   |   0   |
        ---------------------------------------------------------------------
[wc-checker] Initializing working copy...
[wc-checker] SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder".
[wc-checker] SLF4J: Defaulting to no-operation (NOP) logger implementation
[wc-checker] SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for 
further details.
[wc-checker] Checking working copy status...

-jenkins-base:

BUILD SUCCESSFUL
Total time: 148 minutes 56 seconds
Archiving artifacts
WARN: No artifacts found that match the file pattern 
"**/*.events,heapdumps/**,**/hs_err_pid*". Configuration error?
WARN: java.lang.InterruptedException: no matches found within 10000
Recording test results
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to