Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.x/1672/

1 tests failed.
FAILED:  
org.apache.solr.cloud.autoscaling.MetricTriggerIntegrationTest.testMetricTrigger

Error Message:
The trigger did not fire at all

Stack Trace:
java.lang.AssertionError: The trigger did not fire at all
        at 
__randomizedtesting.SeedInfo.seed([474D9B647193201A:FD41ACEB2E7BF655]:0)
        at org.junit.Assert.fail(Assert.java:89)
        at org.junit.Assert.assertTrue(Assert.java:42)
        at 
org.apache.solr.cloud.autoscaling.MetricTriggerIntegrationTest.testMetricTrigger(MetricTriggerIntegrationTest.java:195)
        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:1750)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at org.junit.rules.RunRules.evaluate(RunRules.java:20)
        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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at org.junit.rules.RunRules.evaluate(RunRules.java:20)
        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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
        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 14895 lines...]
   [junit4] Suite: 
org.apache.solr.cloud.autoscaling.MetricTriggerIntegrationTest
   [junit4]   2> 1199381 INFO  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker) [     ] 
o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to 
test-framework derived value of 
'/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/server/solr/configsets/_default/conf'
   [junit4]   2> 1199381 INFO  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker) [     ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 1199382 INFO  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.MetricTriggerIntegrationTest_474D9B647193201A-001/data-dir-100-001
   [junit4]   2> 1199382 WARN  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker) [     ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=102 numCloses=102
   [junit4]   2> 1199382 INFO  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 1199384 INFO  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 1199385 INFO  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker) [     ] 
o.a.s.c.SolrCloudTestCase Using per-replica state
   [junit4]   2> 1199385 INFO  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker) [     ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.MetricTriggerIntegrationTest_474D9B647193201A-001/tempDir-001
   [junit4]   2> 1199386 INFO  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker) [     ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1199386 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
   [junit4]   2> 1199386 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 1199387 WARN  (ZkTestServer Run Thread) [     ] 
o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
   [junit4]   2> 1199486 INFO  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker) [     ] 
o.a.s.c.ZkTestServer start zk server on port: 44687
   [junit4]   2> 1199486 INFO  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker) [     ] 
o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:44687
   [junit4]   2> 1199486 INFO  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker) [     ] 
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:44687
   [junit4]   2> 1199486 INFO  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker) [     ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1 44687
   [junit4]   2> 1199491 INFO  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1199493 INFO  (zkConnectionManagerCallback-14136-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1199493 INFO  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1199503 INFO  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1199511 INFO  (zkConnectionManagerCallback-14138-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1199511 INFO  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1199516 INFO  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1199519 INFO  (zkConnectionManagerCallback-14140-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1199519 INFO  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1199521 WARN  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker-SendThread(127.0.0.1:44687))
 [     ] o.a.z.ClientCnxn An exception was thrown while closing send thread for 
session 0x103abea88b70002.
   [junit4]   2>           => EndOfStreamException: Unable to read additional 
data from server sessionid 0x103abea88b70002, likely server has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
   [junit4]   2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable 
to read additional data from server sessionid 0x103abea88b70002, likely server 
has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) 
~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350)
 ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) 
[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 1199625 INFO  (jetty-launcher-14141-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1199626 INFO  (jetty-launcher-14141-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 1199626 INFO  (jetty-launcher-14141-thread-1) [     ] 
o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: 
e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_281-b09
   [junit4]   2> 1199627 INFO  (jetty-launcher-14141-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1199627 INFO  (jetty-launcher-14141-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 1199627 INFO  (jetty-launcher-14141-thread-2) [     ] 
o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: 
e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_281-b09
   [junit4]   2> 1199627 INFO  (jetty-launcher-14141-thread-1) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1199627 INFO  (jetty-launcher-14141-thread-1) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1199627 INFO  (jetty-launcher-14141-thread-1) [     ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 1199628 INFO  (jetty-launcher-14141-thread-1) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1e94b5bf{/solr,null,AVAILABLE}
   [junit4]   2> 1199629 INFO  (jetty-launcher-14141-thread-2) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1199629 INFO  (jetty-launcher-14141-thread-2) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1199629 INFO  (jetty-launcher-14141-thread-2) [     ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 1199629 INFO  (jetty-launcher-14141-thread-2) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@3bbf726c{/solr,null,AVAILABLE}
   [junit4]   2> 1199630 INFO  (jetty-launcher-14141-thread-1) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@71702e3f{SSL, (ssl, 
http/1.1)}{127.0.0.1:44313}
   [junit4]   2> 1199630 INFO  (jetty-launcher-14141-thread-1) [     ] 
o.e.j.s.Server Started @1199668ms
   [junit4]   2> 1199630 INFO  (jetty-launcher-14141-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
zkHost=127.0.0.1:44687/solr, hostPort=44313}
   [junit4]   2> 1199630 ERROR (jetty-launcher-14141-thread-1) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1199630 INFO  (jetty-launcher-14141-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1199630 INFO  (jetty-launcher-14141-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.9.0
   [junit4]   2> 1199630 INFO  (jetty-launcher-14141-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1199630 INFO  (jetty-launcher-14141-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
   [junit4]   2> 1199630 INFO  (jetty-launcher-14141-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2021-03-02T22:09:43.021Z
   [junit4]   2> 1199631 INFO  (jetty-launcher-14141-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1199631 INFO  (jetty-launcher-14141-thread-2) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@3a244060{SSL, (ssl, 
http/1.1)}{127.0.0.1:41173}
   [junit4]   2> 1199631 INFO  (jetty-launcher-14141-thread-2) [     ] 
o.e.j.s.Server Started @1199669ms
   [junit4]   2> 1199631 INFO  (jetty-launcher-14141-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
zkHost=127.0.0.1:44687/solr, hostPort=41173}
   [junit4]   2> 1199631 ERROR (jetty-launcher-14141-thread-2) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1199631 INFO  (jetty-launcher-14141-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1199631 INFO  (jetty-launcher-14141-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.9.0
   [junit4]   2> 1199631 INFO  (jetty-launcher-14141-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1199631 INFO  (jetty-launcher-14141-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
   [junit4]   2> 1199631 INFO  (jetty-launcher-14141-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2021-03-02T22:09:43.022Z
   [junit4]   2> 1199632 INFO  (jetty-launcher-14141-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1199632 INFO  (zkConnectionManagerCallback-14143-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1199632 INFO  (jetty-launcher-14141-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1199633 INFO  (zkConnectionManagerCallback-14145-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1199633 INFO  (jetty-launcher-14141-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1199633 INFO  (jetty-launcher-14141-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1199635 INFO  (jetty-launcher-14141-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1199640 WARN  
(jetty-launcher-14141-thread-2-SendThread(127.0.0.1:44687)) [     ] 
o.a.z.ClientCnxn An exception was thrown while closing send thread for session 
0x103abea88b70004.
   [junit4]   2>           => EndOfStreamException: Unable to read additional 
data from server sessionid 0x103abea88b70004, likely server has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
   [junit4]   2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable 
to read additional data from server sessionid 0x103abea88b70004, likely server 
has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) 
~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350)
 ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) 
[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 1199641 WARN  
(jetty-launcher-14141-thread-1-SendThread(127.0.0.1:44687)) [     ] 
o.a.z.ClientCnxn An exception was thrown while closing send thread for session 
0x103abea88b70003.
   [junit4]   2>           => EndOfStreamException: Unable to read additional 
data from server sessionid 0x103abea88b70003, likely server has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
   [junit4]   2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable 
to read additional data from server sessionid 0x103abea88b70003, likely server 
has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) 
~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350)
 ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) 
[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 1200572 INFO  (jetty-launcher-14141-thread-2) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 1200573 WARN  (jetty-launcher-14141-thread-2) [     ] 
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport 
since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 1200573 WARN  (jetty-launcher-14141-thread-2) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@5d83c8d5[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1200573 WARN  (jetty-launcher-14141-thread-2) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@5d83c8d5[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1200576 WARN  (jetty-launcher-14141-thread-2) [     ] 
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport 
since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 1200577 WARN  (jetty-launcher-14141-thread-2) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@105fafdf[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1200577 WARN  (jetty-launcher-14141-thread-2) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@105fafdf[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1200578 INFO  (jetty-launcher-14141-thread-2) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44687/solr
   [junit4]   2> 1200579 INFO  (jetty-launcher-14141-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1200583 INFO  (zkConnectionManagerCallback-14159-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1200583 INFO  (jetty-launcher-14141-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1200584 WARN  
(jetty-launcher-14141-thread-2-SendThread(127.0.0.1:44687)) [     ] 
o.a.z.ClientCnxn An exception was thrown while closing send thread for session 
0x103abea88b70005.
   [junit4]   2>           => EndOfStreamException: Unable to read additional 
data from server sessionid 0x103abea88b70005, likely server has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
   [junit4]   2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable 
to read additional data from server sessionid 0x103abea88b70005, likely server 
has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) 
~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350)
 ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) 
[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 1200685 INFO  (jetty-launcher-14141-thread-2) 
[n:127.0.0.1:41173_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 1200687 INFO  (zkConnectionManagerCallback-14161-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1200687 INFO  (jetty-launcher-14141-thread-2) 
[n:127.0.0.1:41173_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 1200746 INFO  (jetty-launcher-14141-thread-2) 
[n:127.0.0.1:41173_solr     ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:41173_solr
   [junit4]   2> 1200747 INFO  (jetty-launcher-14141-thread-2) 
[n:127.0.0.1:41173_solr     ] o.a.s.c.Overseer Overseer 
(id=73091042772451334-127.0.0.1:41173_solr-n_0000000000) starting
   [junit4]   2> 1200752 INFO  (jetty-launcher-14141-thread-2) 
[n:127.0.0.1:41173_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:41173_solr
   [junit4]   2> 1200753 INFO  
(OverseerStateUpdate-73091042772451334-127.0.0.1:41173_solr-n_0000000000) 
[n:127.0.0.1:41173_solr     ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:41173_solr
   [junit4]   2> 1200754 DEBUG 
(OverseerAutoScalingTriggerThread-73091042772451334-127.0.0.1:41173_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and 
.scheduled_maintenance triggers
   [junit4]   2> 1200754 INFO  
(OverseerStateUpdate-73091042772451334-127.0.0.1:41173_solr-n_0000000000) 
[n:127.0.0.1:41173_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1200755 DEBUG 
(OverseerAutoScalingTriggerThread-73091042772451334-127.0.0.1:41173_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with 
znode version 1
   [junit4]   2> 1200756 INFO  (jetty-launcher-14141-thread-2) 
[n:127.0.0.1:41173_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 1200756 WARN  (jetty-launcher-14141-thread-2) 
[n:127.0.0.1:41173_solr     ] o.a.s.c.CoreContainer Not all security plugins 
configured!  authentication=disabled authorization=disabled.  Solr is only as 
secure as you make it. Consider configuring authentication/authorization before 
exposing Solr to users internal or external.  See 
https://s.apache.org/solrsecurity for more info
   [junit4]   2> 1200757 DEBUG 
(OverseerAutoScalingTriggerThread-73091042772451334-127.0.0.1:41173_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, 
lastZnodeVersion 0
   [junit4]   2> 1200757 DEBUG 
(OverseerAutoScalingTriggerThread-73091042772451334-127.0.0.1:41173_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto 
znodeVersion 1
   [junit4]   2> 1200765 DEBUG 
(OverseerAutoScalingTriggerThread-73091042772451334-127.0.0.1:41173_solr-n_0000000000)
 [     ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial 
livenodes: [127.0.0.1:41173_solr]
   [junit4]   2> 1200767 DEBUG 
(OverseerAutoScalingTriggerThread-73091042772451334-127.0.0.1:41173_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / 
nodeAdded markers
   [junit4]   2> 1200767 DEBUG (ScheduledTrigger-14166-thread-1) [     ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1 and last live nodes: 1
   [junit4]   2> 1200767 INFO  (jetty-launcher-14141-thread-2) 
[n:127.0.0.1:41173_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1200768 DEBUG 
(OverseerAutoScalingTriggerThread-73091042772451334-127.0.0.1:41173_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, 
lastZnodeVersion 1
   [junit4]   2> 1200796 INFO  (jetty-launcher-14141-thread-2) 
[n:127.0.0.1:41173_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_41173.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6e973e16
   [junit4]   2> 1200804 INFO  (jetty-launcher-14141-thread-2) 
[n:127.0.0.1:41173_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_41173.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6e973e16
   [junit4]   2> 1200804 INFO  (jetty-launcher-14141-thread-2) 
[n:127.0.0.1:41173_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_41173.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6e973e16
   [junit4]   2> 1200805 INFO  (jetty-launcher-14141-thread-2) 
[n:127.0.0.1:41173_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.MetricTriggerIntegrationTest_474D9B647193201A-001/tempDir-001/node2
   [junit4]   2> 1200867 INFO  (jetty-launcher-14141-thread-1) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 1200867 WARN  (jetty-launcher-14141-thread-1) [     ] 
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport 
since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 1200868 WARN  (jetty-launcher-14141-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@32327e85[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1200868 WARN  (jetty-launcher-14141-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@32327e85[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1200871 WARN  (jetty-launcher-14141-thread-1) [     ] 
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport 
since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 1200875 WARN  (jetty-launcher-14141-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@5e91403c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1200875 WARN  (jetty-launcher-14141-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@5e91403c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1200876 INFO  (jetty-launcher-14141-thread-1) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44687/solr
   [junit4]   2> 1200877 INFO  (jetty-launcher-14141-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1200879 INFO  (zkConnectionManagerCallback-14181-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1200879 INFO  (jetty-launcher-14141-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1200981 INFO  (jetty-launcher-14141-thread-1) 
[n:127.0.0.1:44313_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 1200982 INFO  (zkConnectionManagerCallback-14183-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1200982 INFO  (jetty-launcher-14141-thread-1) 
[n:127.0.0.1:44313_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 1200986 INFO  (jetty-launcher-14141-thread-1) 
[n:127.0.0.1:44313_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1200989 INFO  (jetty-launcher-14141-thread-1) 
[n:127.0.0.1:44313_solr     ] o.a.s.c.ZkController Publish 
node=127.0.0.1:44313_solr as DOWN
   [junit4]   2> 1200989 INFO  (jetty-launcher-14141-thread-1) 
[n:127.0.0.1:44313_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 1200989 INFO  (jetty-launcher-14141-thread-1) 
[n:127.0.0.1:44313_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:44313_solr
   [junit4]   2> 1200990 INFO  (zkCallback-14160-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1200991 INFO  (zkCallback-14182-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1200996 INFO  (jetty-launcher-14141-thread-1) 
[n:127.0.0.1:44313_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 1200997 WARN  (jetty-launcher-14141-thread-1) 
[n:127.0.0.1:44313_solr     ] o.a.s.c.CoreContainer Not all security plugins 
configured!  authentication=disabled authorization=disabled.  Solr is only as 
secure as you make it. Consider configuring authentication/authorization before 
exposing Solr to users internal or external.  See 
https://s.apache.org/solrsecurity for more info
   [junit4]   2> 1201008 INFO  (jetty-launcher-14141-thread-1) 
[n:127.0.0.1:44313_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1201065 INFO  (jetty-launcher-14141-thread-1) 
[n:127.0.0.1:44313_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44313.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6e973e16
   [junit4]   2> 1201074 INFO  (jetty-launcher-14141-thread-1) 
[n:127.0.0.1:44313_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44313.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6e973e16
   [junit4]   2> 1201074 INFO  (jetty-launcher-14141-thread-1) 
[n:127.0.0.1:44313_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44313.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6e973e16
   [junit4]   2> 1201075 INFO  (jetty-launcher-14141-thread-1) 
[n:127.0.0.1:44313_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.MetricTriggerIntegrationTest_474D9B647193201A-001/tempDir-001/node1
   [junit4]   2> 1201095 INFO  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker) [     ] 
o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2
   [junit4]   2> 1201099 INFO  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1201100 INFO  (zkConnectionManagerCallback-14196-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1201100 INFO  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1201101 INFO  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 1201102 INFO  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker) [     ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:44687/solr ready
   [junit4]   2> 1201151 INFO  (qtp1049288101-24850) [n:127.0.0.1:44313_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling 
params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 1201200 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr    
 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 1201200 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
 status=0 QTime=0
   [junit4]   2> 1201203 INFO  (qtp1049288101-24851) [n:127.0.0.1:44313_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
 status=0 QTime=0
   [junit4]   2> 1201203 DEBUG (qtp1977526928-24858) [n:127.0.0.1:41173_solr    
 ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1201204 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling 
params={wt=javabin&version=2} status=0 QTime=12
   [junit4]   2> 1201204 DEBUG (zkCallback-14160-thread-1) [     ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
2
   [junit4]   2> 1201205 DEBUG 
(OverseerAutoScalingTriggerThread-73091042772451334-127.0.0.1:41173_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto 
znodeVersion 2
   [junit4]   2> 1201207 DEBUG 
(OverseerAutoScalingTriggerThread-73091042772451334-127.0.0.1:41173_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / 
nodeAdded markers
   [junit4]   2> 1201207 DEBUG 
(OverseerAutoScalingTriggerThread-73091042772451334-127.0.0.1:41173_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, 
lastZnodeVersion 2
   [junit4]   2> 1201225 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.a.s.SolrTestCaseJ4 ###Starting testMetricTrigger
   [junit4]   2> 1201236 INFO  
(OverseerThreadFactory-14168-thread-1-processing-n:127.0.0.1:41173_solr) 
[n:127.0.0.1:41173_solr     ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
testMetricTrigger
   [junit4]   2> 1201392 INFO  
(OverseerStateUpdate-73091042772451334-127.0.0.1:41173_solr-n_0000000000) 
[n:127.0.0.1:41173_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "core":"testMetricTrigger_shard1_replica_n1",
   [junit4]   2>   "node_name":"127.0.0.1:41173_solr",
   [junit4]   2>   "base_url":"https://127.0.0.1:41173/solr";,
   [junit4]   2>   "collection":"testMetricTrigger",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1201394 INFO  
(OverseerStateUpdate-73091042772451334-127.0.0.1:41173_solr-n_0000000000) 
[n:127.0.0.1:41173_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "core":"testMetricTrigger_shard1_replica_n2",
   [junit4]   2>   "node_name":"127.0.0.1:44313_solr",
   [junit4]   2>   "base_url":"https://127.0.0.1:44313/solr";,
   [junit4]   2>   "collection":"testMetricTrigger",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1201396 INFO  
(OverseerStateUpdate-73091042772451334-127.0.0.1:41173_solr-n_0000000000) 
[n:127.0.0.1:41173_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "core":"testMetricTrigger_shard2_replica_n4",
   [junit4]   2>   "node_name":"127.0.0.1:41173_solr",
   [junit4]   2>   "base_url":"https://127.0.0.1:41173/solr";,
   [junit4]   2>   "collection":"testMetricTrigger",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1201398 INFO  
(OverseerStateUpdate-73091042772451334-127.0.0.1:41173_solr-n_0000000000) 
[n:127.0.0.1:41173_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "core":"testMetricTrigger_shard2_replica_n6",
   [junit4]   2>   "node_name":"127.0.0.1:44313_solr",
   [junit4]   2>   "base_url":"https://127.0.0.1:44313/solr";,
   [junit4]   2>   "collection":"testMetricTrigger",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1201604 INFO  (qtp1049288101-24852) [n:127.0.0.1:44313_solr    
x:testMetricTrigger_shard1_replica_n2 ] o.a.s.h.a.CoreAdminOperation core 
create command 
qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=testMetricTrigger_shard1_replica_n2&action=CREATE&numShards=2&collection=testMetricTrigger&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1201609 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr    
x:testMetricTrigger_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core 
create command 
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=testMetricTrigger_shard1_replica_n1&action=CREATE&numShards=2&collection=testMetricTrigger&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1201610 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr    
x:testMetricTrigger_shard2_replica_n4 ] o.a.s.h.a.CoreAdminOperation core 
create command 
qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf&newCollection=true&name=testMetricTrigger_shard2_replica_n4&action=CREATE&numShards=2&collection=testMetricTrigger&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1201616 INFO  (qtp1049288101-24851) [n:127.0.0.1:44313_solr    
x:testMetricTrigger_shard2_replica_n6 ] o.a.s.h.a.CoreAdminOperation core 
create command 
qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf&newCollection=true&name=testMetricTrigger_shard2_replica_n6&action=CREATE&numShards=2&collection=testMetricTrigger&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1201623 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard2 r:core_node7 x:testMetricTrigger_shard2_replica_n4 
] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
   [junit4]   2> 1201630 INFO  (qtp1049288101-24851) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard2 r:core_node8 x:testMetricTrigger_shard2_replica_n6 
] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
   [junit4]   2> 1201637 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard1 r:core_node3 x:testMetricTrigger_shard1_replica_n1 
] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
   [junit4]   2> 1201655 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard2 r:core_node7 x:testMetricTrigger_shard2_replica_n4 
] o.a.s.s.IndexSchema Schema name=minimal
   [junit4]   2> 1201655 INFO  (qtp1049288101-24852) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard1 r:core_node5 x:testMetricTrigger_shard1_replica_n2 
] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
   [junit4]   2> 1201656 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard2 r:core_node7 x:testMetricTrigger_shard2_replica_n4 
] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1201656 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard2 r:core_node7 x:testMetricTrigger_shard2_replica_n4 
] o.a.s.c.CoreContainer Creating SolrCore 'testMetricTrigger_shard2_replica_n4' 
using configuration from configset conf, trusted=true
   [junit4]   2> 1201657 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard2 r:core_node7 x:testMetricTrigger_shard2_replica_n4 
] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_41173.solr.core.testMetricTrigger.shard2.replica_n4' (registry 
'solr.core.testMetricTrigger.shard2.replica_n4') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6e973e16
   [junit4]   2> 1201657 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard2 r:core_node7 x:testMetricTrigger_shard2_replica_n4 
] o.a.s.c.SolrCore [[testMetricTrigger_shard2_replica_n4] ] Opening new 
SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.MetricTriggerIntegrationTest_474D9B647193201A-001/tempDir-001/node2/testMetricTrigger_shard2_replica_n4],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.MetricTriggerIntegrationTest_474D9B647193201A-001/tempDir-001/node2/testMetricTrigger_shard2_replica_n4/data/]
   [junit4]   2> 1201660 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard1 r:core_node3 x:testMetricTrigger_shard1_replica_n1 
] o.a.s.s.IndexSchema Schema name=minimal
   [junit4]   2> 1201660 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard1 r:core_node3 x:testMetricTrigger_shard1_replica_n1 
] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1201660 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard1 r:core_node3 x:testMetricTrigger_shard1_replica_n1 
] o.a.s.c.CoreContainer Creating SolrCore 'testMetricTrigger_shard1_replica_n1' 
using configuration from configset conf, trusted=true
   [junit4]   2> 1201660 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard1 r:core_node3 x:testMetricTrigger_shard1_replica_n1 
] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_41173.solr.core.testMetricTrigger.shard1.replica_n1' (registry 
'solr.core.testMetricTrigger.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6e973e16
   [junit4]   2> 1201661 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard1 r:core_node3 x:testMetricTrigger_shard1_replica_n1 
] o.a.s.c.SolrCore [[testMetricTrigger_shard1_replica_n1] ] Opening new 
SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.MetricTriggerIntegrationTest_474D9B647193201A-001/tempDir-001/node2/testMetricTrigger_shard1_replica_n1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.MetricTriggerIntegrationTest_474D9B647193201A-001/tempDir-001/node2/testMetricTrigger_shard1_replica_n1/data/]
   [junit4]   2> 1201663 INFO  (qtp1049288101-24851) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard2 r:core_node8 x:testMetricTrigger_shard2_replica_n6 
] o.a.s.s.IndexSchema Schema name=minimal
   [junit4]   2> 1201663 INFO  (qtp1049288101-24851) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard2 r:core_node8 x:testMetricTrigger_shard2_replica_n6 
] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1201663 INFO  (qtp1049288101-24851) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard2 r:core_node8 x:testMetricTrigger_shard2_replica_n6 
] o.a.s.c.CoreContainer Creating SolrCore 'testMetricTrigger_shard2_replica_n6' 
using configuration from configset conf, trusted=true
   [junit4]   2> 1201663 INFO  (qtp1049288101-24851) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard2 r:core_node8 x:testMetricTrigger_shard2_replica_n6 
] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44313.solr.core.testMetricTrigger.shard2.replica_n6' (registry 
'solr.core.testMetricTrigger.shard2.replica_n6') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6e973e16
   [junit4]   2> 1201664 INFO  (qtp1049288101-24851) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard2 r:core_node8 x:testMetricTrigger_shard2_replica_n6 
] o.a.s.c.SolrCore [[testMetricTrigger_shard2_replica_n6] ] Opening new 
SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.MetricTriggerIntegrationTest_474D9B647193201A-001/tempDir-001/node1/testMetricTrigger_shard2_replica_n6],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.MetricTriggerIntegrationTest_474D9B647193201A-001/tempDir-001/node1/testMetricTrigger_shard2_replica_n6/data/]
   [junit4]   2> 1201672 INFO  (qtp1049288101-24852) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard1 r:core_node5 x:testMetricTrigger_shard1_replica_n2 
] o.a.s.s.IndexSchema Schema name=minimal
   [junit4]   2> 1201673 INFO  (qtp1049288101-24852) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard1 r:core_node5 x:testMetricTrigger_shard1_replica_n2 
] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1201673 INFO  (qtp1049288101-24852) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard1 r:core_node5 x:testMetricTrigger_shard1_replica_n2 
] o.a.s.c.CoreContainer Creating SolrCore 'testMetricTrigger_shard1_replica_n2' 
using configuration from configset conf, trusted=true
   [junit4]   2> 1201673 INFO  (qtp1049288101-24852) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard1 r:core_node5 x:testMetricTrigger_shard1_replica_n2 
] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44313.solr.core.testMetricTrigger.shard1.replica_n2' (registry 
'solr.core.testMetricTrigger.shard1.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6e973e16
   [junit4]   2> 1201673 INFO  (qtp1049288101-24852) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard1 r:core_node5 x:testMetricTrigger_shard1_replica_n2 
] o.a.s.c.SolrCore [[testMetricTrigger_shard1_replica_n2] ] Opening new 
SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.MetricTriggerIntegrationTest_474D9B647193201A-001/tempDir-001/node1/testMetricTrigger_shard1_replica_n2],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.MetricTriggerIntegrationTest_474D9B647193201A-001/tempDir-001/node1/testMetricTrigger_shard1_replica_n2/data/]
   [junit4]   2> 1201739 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard1 r:core_node3 x:testMetricTrigger_shard1_replica_n1 
] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1201739 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard1 r:core_node3 x:testMetricTrigger_shard1_replica_n1 
] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1201741 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard1 r:core_node3 x:testMetricTrigger_shard1_replica_n1 
] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1201741 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard1 r:core_node3 x:testMetricTrigger_shard1_replica_n1 
] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1201759 INFO  (qtp1049288101-24852) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard1 r:core_node5 x:testMetricTrigger_shard1_replica_n2 
] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1201759 INFO  (qtp1049288101-24852) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard1 r:core_node5 x:testMetricTrigger_shard1_replica_n2 
] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1201761 INFO  (qtp1049288101-24852) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard1 r:core_node5 x:testMetricTrigger_shard1_replica_n2 
] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1201761 INFO  (qtp1049288101-24852) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard1 r:core_node5 x:testMetricTrigger_shard1_replica_n2 
] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1201764 INFO  (qtp1049288101-24851) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard2 r:core_node8 x:testMetricTrigger_shard2_replica_n6 
] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1201764 INFO  (qtp1049288101-24851) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard2 r:core_node8 x:testMetricTrigger_shard2_replica_n6 
] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1201764 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard2 r:core_node7 x:testMetricTrigger_shard2_replica_n4 
] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1201764 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard2 r:core_node7 x:testMetricTrigger_shard2_replica_n4 
] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1201765 INFO  (qtp1049288101-24851) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard2 r:core_node8 x:testMetricTrigger_shard2_replica_n6 
] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1201765 INFO  (qtp1049288101-24851) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard2 r:core_node8 x:testMetricTrigger_shard2_replica_n6 
] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1201765 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard2 r:core_node7 x:testMetricTrigger_shard2_replica_n4 
] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1201765 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard2 r:core_node7 x:testMetricTrigger_shard2_replica_n4 
] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1201767 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard1 r:core_node3 x:testMetricTrigger_shard1_replica_n1 
] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 1201767 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard1 r:core_node3 x:testMetricTrigger_shard1_replica_n1 
] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 1201767 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard2 r:core_node7 x:testMetricTrigger_shard2_replica_n4 
] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 1201767 INFO  (qtp1049288101-24851) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard2 r:core_node8 x:testMetricTrigger_shard2_replica_n6 
] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 1201768 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard1 r:core_node3 x:testMetricTrigger_shard1_replica_n1 
] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 1201768 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard1 r:core_node3 x:testMetricTrigger_shard1_replica_n1 
] o.a.s.u.UpdateLog Could not find max version in index or recent updates, 
using new clock 1693159768886083584
   [junit4]   2> 1201768 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard2 r:core_node7 x:testMetricTrigger_shard2_replica_n4 
] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 1201768 INFO  (qtp1049288101-24852) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard1 r:core_node5 x:testMetricTrigger_shard1_replica_n2 
] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 1201769 DEBUG (ScheduledTrigger-14166-thread-2) [     ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2 and last live nodes: 1
   [junit4]   2> 1201769 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard2 r:core_node7 x:testMetricTrigger_shard2_replica_n4 
] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 1201769 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard2 r:core_node7 x:testMetricTrigger_shard2_replica_n4 
] o.a.s.u.UpdateLog Could not find max version in index or recent updates, 
using new clock 1693159768887132160
   [junit4]   2> 1201770 INFO  (qtp1049288101-24852) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard1 r:core_node5 x:testMetricTrigger_shard1_replica_n2 
] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 1201771 INFO  (qtp1049288101-24852) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard1 r:core_node5 x:testMetricTrigger_shard1_replica_n2 
] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 1201771 INFO  (qtp1049288101-24852) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard1 r:core_node5 x:testMetricTrigger_shard1_replica_n2 
] o.a.s.u.UpdateLog Could not find max version in index or recent updates, 
using new clock 1693159768889229312
   [junit4]   2> 1201772 INFO  
(searcherExecutor-14200-thread-1-processing-n:127.0.0.1:41173_solr 
x:testMetricTrigger_shard1_replica_n1 c:testMetricTrigger s:shard1 
r:core_node3) [n:127.0.0.1:41173_solr c:testMetricTrigger s:shard1 r:core_node3 
x:testMetricTrigger_shard1_replica_n1 ] o.a.s.c.SolrCore 
[testMetricTrigger_shard1_replica_n1]  Registered new searcher autowarm time: 0 
ms
   [junit4]   2> 1201773 INFO  (qtp1049288101-24851) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard2 r:core_node8 x:testMetricTrigger_shard2_replica_n6 
] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 1201774 INFO  (qtp1049288101-24851) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard2 r:core_node8 x:testMetricTrigger_shard2_replica_n6 
] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 1201774 INFO  (qtp1049288101-24851) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard2 r:core_node8 x:testMetricTrigger_shard2_replica_n6 
] o.a.s.u.UpdateLog Could not find max version in index or recent updates, 
using new clock 1693159768892375040
   [junit4]   2> 1201774 INFO  
(searcherExecutor-14198-thread-1-processing-n:127.0.0.1:41173_solr 
x:testMetricTrigger_shard2_replica_n4 c:testMetricTrigger s:shard2 
r:core_node7) [n:127.0.0.1:41173_solr c:testMetricTrigger s:shard2 r:core_node7 
x:testMetricTrigger_shard2_replica_n4 ] o.a.s.c.SolrCore 
[testMetricTrigger_shard2_replica_n4]  Registered new searcher autowarm time: 0 
ms
   [junit4]   2> 1201775 INFO  
(searcherExecutor-14204-thread-1-processing-n:127.0.0.1:44313_solr 
x:testMetricTrigger_shard1_replica_n2 c:testMetricTrigger s:shard1 
r:core_node5) [n:127.0.0.1:44313_solr c:testMetricTrigger s:shard1 r:core_node5 
x:testMetricTrigger_shard1_replica_n2 ] o.a.s.c.SolrCore 
[testMetricTrigger_shard1_replica_n2]  Registered new searcher autowarm time: 0 
ms
   [junit4]   2> 1201777 INFO  
(searcherExecutor-14202-thread-1-processing-n:127.0.0.1:44313_solr 
x:testMetricTrigger_shard2_replica_n6 c:testMetricTrigger s:shard2 
r:core_node8) [n:127.0.0.1:44313_solr c:testMetricTrigger s:shard2 r:core_node8 
x:testMetricTrigger_shard2_replica_n6 ] o.a.s.c.SolrCore 
[testMetricTrigger_shard2_replica_n6]  Registered new searcher autowarm time: 0 
ms
   [junit4]   2> 1201778 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard2 r:core_node7 x:testMetricTrigger_shard2_replica_n4 
] o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/testMetricTrigger/terms/shard2 to Terms{values={core_node7=0}, 
version=0}
   [junit4]   2> 1201778 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard2 r:core_node7 x:testMetricTrigger_shard2_replica_n4 
] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/testMetricTrigger/leaders/shard2
   [junit4]   2> 1201780 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard1 r:core_node3 x:testMetricTrigger_shard1_replica_n1 
] o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/testMetricTrigger/terms/shard1 to Terms{values={core_node3=0}, 
version=0}
   [junit4]   2> 1201780 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard1 r:core_node3 x:testMetricTrigger_shard1_replica_n1 
] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/testMetricTrigger/leaders/shard1
   [junit4]   2> 1201782 INFO  (qtp1049288101-24851) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard2 r:core_node8 x:testMetricTrigger_shard2_replica_n6 
] o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/testMetricTrigger/terms/shard2 to Terms{values={core_node7=0, 
core_node8=0}, version=1}
   [junit4]   2> 1201782 INFO  (qtp1049288101-24851) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard2 r:core_node8 x:testMetricTrigger_shard2_replica_n6 
] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/testMetricTrigger/leaders/shard2
   [junit4]   2> 1201784 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard2 r:core_node7 x:testMetricTrigger_shard2_replica_n4 
] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1201784 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard2 r:core_node7 x:testMetricTrigger_shard2_replica_n4 
] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1201784 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard2 r:core_node7 x:testMetricTrigger_shard2_replica_n4 
] o.a.s.c.SyncStrategy Sync replicas to 
https://127.0.0.1:41173/solr/testMetricTrigger_shard2_replica_n4/
   [junit4]   2> 1201785 INFO  (qtp1049288101-24852) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard1 r:core_node5 x:testMetricTrigger_shard1_replica_n2 
] o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/testMetricTrigger/terms/shard1 to Terms{values={core_node3=0, 
core_node5=0}, version=1}
   [junit4]   2> 1201785 INFO  (qtp1049288101-24852) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard1 r:core_node5 x:testMetricTrigger_shard1_replica_n2 
] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/testMetricTrigger/leaders/shard1
   [junit4]   2> 1201786 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard2 r:core_node7 x:testMetricTrigger_shard2_replica_n4 
] o.a.s.u.PeerSync PeerSync: core=testMetricTrigger_shard2_replica_n4 
url=https://127.0.0.1:41173/solr  START 
replicas=[https://127.0.0.1:44313/solr/testMetricTrigger_shard2_replica_n6/] 
nUpdates=100
   [junit4]   2> 1201787 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard2 r:core_node7 x:testMetricTrigger_shard2_replica_n4 
] o.a.s.u.PeerSync PeerSync: core=testMetricTrigger_shard2_replica_n4 
url=https://127.0.0.1:41173/solr  DONE. We have no versions. sync failed.
   [junit4]   2> 1201787 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard1 r:core_node3 x:testMetricTrigger_shard1_replica_n1 
] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1201787 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard1 r:core_node3 x:testMetricTrigger_shard1_replica_n1 
] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1201787 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard1 r:core_node3 x:testMetricTrigger_shard1_replica_n1 
] o.a.s.c.SyncStrategy Sync replicas to 
https://127.0.0.1:41173/solr/testMetricTrigger_shard1_replica_n1/
   [junit4]   2> 1201788 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard1 r:core_node3 x:testMetricTrigger_shard1_replica_n1 
] o.a.s.u.PeerSync PeerSync: core=testMetricTrigger_shard1_replica_n1 
url=https://127.0.0.1:41173/solr  START 
replicas=[https://127.0.0.1:44313/solr/testMetricTrigger_shard1_replica_n2/] 
nUpdates=100
   [junit4]   2> 1201788 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard1 r:core_node3 x:testMetricTrigger_shard1_replica_n1 
] o.a.s.u.PeerSync PeerSync: core=testMetricTrigger_shard1_replica_n1 
url=https://127.0.0.1:41173/solr  DONE. We have no versions. sync failed.
   [junit4]   2> 1201794 INFO  (qtp1049288101-24849) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard2 r:core_node8 x:testMetricTrigger_shard2_replica_n6 
] o.a.s.c.S.Request [testMetricTrigger_shard2_replica_n6]  webapp=/solr 
path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1201794 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard2 r:core_node7 x:testMetricTrigger_shard2_replica_n4 
] o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to 
the next candidate
   [junit4]   2> 1201795 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard2 r:core_node7 x:testMetricTrigger_shard2_replica_n4 
] 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> 1201795 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard2 r:core_node7 x:testMetricTrigger_shard2_replica_n4 
] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/testMetricTrigger/leaders/shard2/leader after winning as 
/collections/testMetricTrigger/leader_elect/shard2/election/73091042772451334-core_node7-n_0000000000
   [junit4]   2> 1201796 INFO  (qtp1049288101-24849) [n:127.0.0.1:44313_solr 
c:testMetricTrigger s:shard1 r:core_node5 x:testMetricTrigger_shard1_replica_n2 
] o.a.s.c.S.Request [testMetricTrigger_shard1_replica_n2]  webapp=/solr 
path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1201907 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard1 r:core_node3 x:testMetricTrigger_shard1_replica_n1 
] o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to 
the next candidate
   [junit4]   2> 1201907 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard1 r:core_node3 x:testMetricTrigger_shard1_replica_n1 
] o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - 
we can't sync in that case - we were active before, so become leader anyway
   [junit4]   2> 1201907 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard1 r:core_node3 x:testMetricTrigger_shard1_replica_n1 
] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/testMetricTrigger/leaders/shard1/leader after winning as 
/collections/testMetricTrigger/leader_elect/shard1/election/73091042772451334-core_node3-n_0000000000
   [junit4]   2> 1201909 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard2 r:core_node7 x:testMetricTrigger_shard2_replica_n4 
] o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:41173/solr/testMetricTrigger_shard2_replica_n4/ shard2
   [junit4]   2> 1201910 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard1 r:core_node3 x:testMetricTrigger_shard1_replica_n1 
] o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:41173/solr/testMetricTrigger_shard1_replica_n1/ shard1
   [junit4]   2> 1202012 INFO  (zkCallback-14160-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testMetricTrigger/state.json] for collection 
[testMetricTrigger] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1202013 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard1 r:core_node3 x:testMetricTrigger_shard1_replica_n1 
] o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 1202015 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr 
c:testMetricTrigger s:shard2 r:core_node7 x:testMetricTrigger_shard2_replica_n4 
] o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 1202018 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=testMetricTrigger_shard1_replica_n1&action=CREATE&numShards=2&collection=testMetricTrigger&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=409
   [junit4]   2> 1202019 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf&newCollection=true&name=testMetricTrigger_shard2_replica_n4&action=CREATE&numShards=2&collection=testMetricTrigger&shard=shard2&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=409
   [junit4]   2> 1202118 INFO  (zkCallback-14160-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testMetricTrigger/state.json] for collection 
[testMetricTrigger] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1202119 INFO  (zkCallback-14160-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testMetricTrigger/state.json] for collection 
[testMetricTrigger] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1202771 DEBUG (ScheduledTrigger-14166-thread-2) [     ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 1202791 INFO  (qtp1049288101-24851) [n:127.0.0.1:44313_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf&newCollection=true&name=testMetricTrigger_shard2_replica_n6&action=CREATE&numShards=2&collection=testMetricTrigger&shard=shard2&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1175
   [junit4]   2> 1202792 INFO  (qtp1049288101-24852) [n:127.0.0.1:44313_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=testMetricTrigger_shard1_replica_n2&action=CREATE&numShards=2&collection=testMetricTrigger&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1188
   [junit4]   2> 1202794 INFO  (qtp1977526928-24861) [n:127.0.0.1:41173_solr    
 ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at 
most 45 seconds. Check all shard replicas
   [junit4]   2> 1202894 INFO  (zkCallback-14182-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testMetricTrigger/state.json] for collection 
[testMetricTrigger] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1202894 INFO  (zkCallback-14160-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testMetricTrigger/state.json] for collection 
[testMetricTrigger] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1202894 INFO  (zkCallback-14160-thread-3) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testMetricTrigger/state.json] for collection 
[testMetricTrigger] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1202894 INFO  (zkCallback-14182-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testMetricTrigger/state.json] for collection 
[testMetricTrigger] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1202895 INFO  (qtp1977526928-24861) [n:127.0.0.1:41173_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={collection.configName=conf&maxShardsPerNode=2&name=testMetricTrigger&nrtReplicas=2&action=CREATE&numShards=2&wt=javabin&version=2}
 status=0 QTime=1663
   [junit4]   2> 1202895 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection: testMetricTrigger
   [junit4]   2> 1202908 INFO  (qtp1977526928-24860) [n:127.0.0.1:41173_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={wt=javabin&version=2&key=solr.core.testMetricTrigger.shard1.replica_n1:INDEX.sizeInBytes&key=solr.core.testMetricTrigger.shard2.replica_n4:INDEX.sizeInBytes}
 status=0 QTime=0
   [junit4]   2> 1202910 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
 status=0 QTime=0
   [junit4]   2> 1202911 INFO  (qtp1049288101-24853) [n:127.0.0.1:44313_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={wt=javabin&version=2&key=solr.core.testMetricTrigger.shard2.replica_n6:INDEX.sizeInBytes&key=solr.core.testMetricTrigger.shard1.replica_n2:INDEX.sizeInBytes}
 status=0 QTime=0
   [junit4]   2> 1202912 INFO  (qtp1049288101-24850) [n:127.0.0.1:44313_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
 status=0 QTime=0
   [junit4]   2> 1202912 DEBUG (qtp1977526928-24859) [n:127.0.0.1:41173_solr    
 ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1202913 INFO  (qtp1977526928-24859) [n:127.0.0.1:41173_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling 
params={wt=javabin&version=2} status=0 QTime=12
   [junit4]   2> 1202914 DEBUG (zkCallback-14160-thread-1) [     ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
3
   [junit4]   2> 1202914 DEBUG 
(OverseerAutoScalingTriggerThread-73091042772451334-127.0.0.1:41173_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto 
znodeVersion 3
   [junit4]   2> 1202917 INFO  (qtp1977526928-24861) [n:127.0.0.1:41173_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={wt=javabin&version=2&key=solr.core.testMetricTrigger.shard1.replica_n1:INDEX.sizeInBytes&key=solr.core.testMetricTrigger.shard2.replica_n4:INDEX.sizeInBytes}
 status=0 QTime=0
   [junit4]   2> 1202917 DEBUG 
(OverseerAutoScalingTriggerThread-73091042772451334-127.0.0.1:41173_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / 
nodeAdded markers
   [junit4]   2> 1202918 DEBUG 
(OverseerAutoScalingTriggerThread-73091042772451334-127.0.0.1:41173_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3, 
lastZnodeVersion 3
   [junit4]   2> 1202918 INFO  (qtp1977526928-24860) [n:127.0.0.1:41173_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
 status=0 QTime=0
   [junit4]   2> 1202919 INFO  (qtp1049288101-24849) [n:127.0.0.1:44313_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={wt=javabin&version=2&key=solr.core.testMetricTrigger.shard1.replica_n1:INDEX.sizeInBytes}
 status=0 QTime=0
   [junit4]   2> 1202920 INFO  (qtp1049288101-24851) [n:127.0.0.1:44313_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={wt=javabin&version=2&key=solr.core.testMetricTrigger.shard2.replica_n6:INDEX.sizeInBytes&key=solr.core.testMetricTrigger.shard1.replica_n2:INDEX.sizeInBytes}
 status=0 QTime=0
   [junit4]   2> 1202920 INFO  (qtp1977526928-24862) [n:127.0.0.1:41173_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={wt=javabin&version=2&key=solr.core.testMetricTrigger.shard1.replica_n1:INDEX.sizeInBytes}
 status=0 QTime=0
   [junit4]   2> 1202921 INFO  (qtp1049288101-24852) [n:127.0.0.1:44313_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
 status=0 QTime=0
   [junit4]   2> 1202924 DEBUG (qtp1977526928-24859) [n:127.0.0.1:41173_solr    
 ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1202925 INFO  (qtp1977526928-24859) [n:127.0.0.1:41173_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling 
params={wt=javabin&version=2} status=0 QTime=9
   [junit4]   2> 1202926 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding 
port=0)
   [junit4]   2> 1202926 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 
...
   [junit4]   2> 1202926 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; 
git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_281-b09
   [junit4]   2> 1202927 DEBUG (zkCallback-14160-thread-1) [     ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
4
   [junit4]   2> 1202927 DEBUG 
(OverseerAutoScalingTriggerThread-73091042772451334-127.0.0.1:41173_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto 
znodeVersion 4
   [junit4]   2> 1202928 DEBUG 
(OverseerAutoScalingTriggerThread-73091042772451334-127.0.0.1:41173_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / 
nodeAdded markers
   [junit4]   2> 1202928 DEBUG 
(OverseerAutoScalingTriggerThread-73091042772451334-127.0.0.1:41173_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 4, 
lastZnodeVersion 4
   [junit4]   2> 1202932 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1202932 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1202932 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1202932 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@48fe44f3{/solr,null,AVAILABLE}
   [junit4]   2> 1202935 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.e.j.s.AbstractConnector Started ServerConnector@281485d8{SSL, (ssl, 
http/1.1)}{127.0.0.1:41159}
   [junit4]   2> 1202935 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.e.j.s.Server Started @1202973ms
   [junit4]   2> 1202935 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
zkHost=127.0.0.1:44687/solr, hostPort=41159}
   [junit4]   2> 1202935 ERROR 
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may 
be missing or incomplete.
   [junit4]   2> 1202936 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1202936 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? 
version 8.9.0
   [junit4]   2> 1202936 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on 
port null
   [junit4]   2> 1202936 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
   [junit4]   2> 1202936 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2021-03-02T22:09:46.327Z
   [junit4]   2> 1202939 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1202940 INFO  (zkConnectionManagerCallback-14222-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1202940 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1202941 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1202946 WARN  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]-SendThread(127.0.0.1:44687))
 [     ] o.a.z.ClientCnxn An exception was thrown while closing send thread for 
session 0x103abea88b7000a.
   [junit4]   2>           => EndOfStreamException: Unable to read additional 
data from server sessionid 0x103abea88b7000a, likely server has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
   [junit4]   2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable 
to read additional data from server sessionid 0x103abea88b7000a, likely server 
has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) 
~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350)
 ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) 
[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 1203237 INFO  
(OverseerCollectionConfigSetProcessor-73091042772451334-127.0.0.1:41173_solr-n_0000000000)
 [n:127.0.0.1:41173_solr     ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 1203771 DEBUG (ScheduledTrigger-14166-thread-2) [     ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2 and last live nodes: 2
   [junit4]   2> 1203803 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 1203804 WARN  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 
transport since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 1203805 WARN  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@70047981[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1203805 WARN  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured 
for Client@70047981[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1203807 WARN  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 
transport since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 1203808 WARN  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@52c62143[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1203808 WARN  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured 
for Client@52c62143[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1203810 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44687/solr
   [junit4]   2> 1203811 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1203811 INFO  (zkConnectionManagerCallback-14233-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1203811 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1203914 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) 
[n:127.0.0.1:41159_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 1203915 INFO  (zkConnectionManagerCallback-14235-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1203915 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) 
[n:127.0.0.1:41159_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 1203920 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) 
[n:127.0.0.1:41159_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 1203923 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) 
[n:127.0.0.1:41159_solr     ] o.a.s.c.ZkController Publish 
node=127.0.0.1:41159_solr as DOWN
   [junit4]   2> 1203925 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) 
[n:127.0.0.1:41159_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 1203925 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) 
[n:127.0.0.1:41159_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:41159_solr
   [junit4]   2> 1203926 INFO  (qtp1049288101-24853) [n:127.0.0.1:44313_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={wt=javabin&version=2&key=solr.core.testMetricTrigger.shard1.replica_n1:INDEX.sizeInBytes}
 status=0 QTime=0
   [junit4]   2> 1203928 INFO  (qtp1977526928-24858) [n:127.0.0.1:41173_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={wt=javabin&version=2&key=solr.core.testMetricTrigger.shard1.replica_n1:INDEX.sizeInBytes}
 status=0 QTime=0
   [junit4]   2> 1203928 INFO  (zkCallback-14195-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1203928 INFO  (zkCallback-14182-thread-2) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1203928 INFO  (zkCallback-14160-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1203930 INFO  (zkCallback-14234-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1203930 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) 
[n:127.0.0.1:41159_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 1203931 WARN  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) 
[n:127.0.0.1:41159_solr     ] o.a.s.c.CoreContainer Not all security plugins 
configured!  authentication=disabled authorization=disabled.  Solr is only as 
secure as you make it. Consider configuring authentication/authorization before 
exposing Solr to users internal or external.  See 
https://s.apache.org/solrsecurity for more info
   [junit4]   2> 1203942 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) 
[n:127.0.0.1:41159_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1203962 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) 
[n:127.0.0.1:41159_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_41159.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6e973e16
   [junit4]   2> 1203973 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) 
[n:127.0.0.1:41159_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_41159.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6e973e16
   [junit4]   2> 1203973 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) 
[n:127.0.0.1:41159_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_41159.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6e973e16
   [junit4]   2> 1203974 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) 
[n:127.0.0.1:41159_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.MetricTriggerIntegrationTest_474D9B647193201A-001/tempDir-001/node3
   [junit4]   2> 1204000 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding 
port=0)
   [junit4]   2> 1204000 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 
...
   [junit4]   2> 1204000 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; 
git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_281-b09
   [junit4]   2> 1204001 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1204001 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1204001 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 1204001 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@6bc58e7a{/solr,null,AVAILABLE}
   [junit4]   2> 1204002 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.e.j.s.AbstractConnector Started ServerConnector@12ccdb8e{SSL, (ssl, 
http/1.1)}{127.0.0.1:33765}
   [junit4]   2> 1204002 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.e.j.s.Server Started @1204041ms
   [junit4]   2> 1204002 INFO  
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
zkHost=127.0.0.1:44687/solr, hostPort=33765}
   [junit4]   2> 1204002 ERROR 
(TEST-MetricTriggerIntegrationTest.testMetricTrigger-seed#[474D9B647193201A]) [ 
    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may 
be missing or incomplete

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

.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) 
~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350)
 ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) 
[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 1235460 INFO  (jetty-closer-14283-thread-3) [     ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@281485d8{SSL, (ssl, 
http/1.1)}{127.0.0.1:0}
   [junit4]   2> 1235460 INFO  (jetty-closer-14283-thread-3) [     ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@48fe44f3{/solr,null,STOPPED}
   [junit4]   2> 1235460 INFO  (jetty-closer-14283-thread-3) [     ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1235554 INFO  (jetty-closer-14283-thread-2) [     ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@71702e3f{SSL, (ssl, 
http/1.1)}{127.0.0.1:0}
   [junit4]   2> 1235555 INFO  (jetty-closer-14283-thread-2) [     ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@1e94b5bf{/solr,null,STOPPED}
   [junit4]   2> 1235555 INFO  (jetty-closer-14283-thread-2) [     ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1235559 INFO  (jetty-closer-14283-thread-1) [     ] 
o.a.s.c.Overseer Overseer 
(id=73091042772451334-127.0.0.1:41173_solr-n_0000000000) closing
   [junit4]   2> 1235560 INFO  (jetty-closer-14283-thread-1) [     ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@3a244060{SSL, (ssl, 
http/1.1)}{127.0.0.1:0}
   [junit4]   2> 1235560 INFO  (jetty-closer-14283-thread-1) [     ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@3bbf726c{/solr,null,STOPPED}
   [junit4]   2> 1235560 INFO  (jetty-closer-14283-thread-1) [     ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1235660 INFO  (jetty-closer-14283-thread-4) [     ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@12ccdb8e{SSL, (ssl, 
http/1.1)}{127.0.0.1:0}
   [junit4]   2> 1235661 INFO  (jetty-closer-14283-thread-4) [     ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@6bc58e7a{/solr,null,STOPPED}
   [junit4]   2> 1235661 INFO  (jetty-closer-14283-thread-4) [     ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1235662 INFO  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker) [     ] 
o.a.s.c.ZkTestServer Shutting down ZkTestServer.
   [junit4]   2> 1235865 WARN  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer Watch limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        30      /solr/collections/testMetricTrigger/terms/shard1
   [junit4]   2>        7       /solr/collections/testMetricTrigger/terms/shard2
   [junit4]   2>        5       /solr/aliases.json
   [junit4]   2>        4       /solr/packages.json
   [junit4]   2>        4       /solr/security.json
   [junit4]   2>        4       /solr/configs/conf
   [junit4]   2>        4       
/solr/collections/testMetricTrigger/collectionprops.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        93      /solr/collections/testMetricTrigger/state.json
   [junit4]   2>        5       /solr/clusterstate.json
   [junit4]   2>        5       /solr/autoscaling.json
   [junit4]   2>        5       /solr/clusterprops.json
   [junit4]   2>        2       
/solr/overseer_elect/election/73091042772451336-127.0.0.1:44313_solr-n_0000000001
   [junit4]   2>        2       
/solr/collections/testMetricTrigger/leader_elect/shard1/election/73091042772451336-core_node5-n_0000000001
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        53      /solr/overseer/queue
   [junit4]   2>        22      /solr/live_nodes
   [junit4]   2>        17      /solr/collections/testMetricTrigger/state.json
   [junit4]   2>        8       /solr/collections
   [junit4]   2>        8       /solr/overseer/collection-queue-work
   [junit4]   2>        2       /solr/autoscaling/events/metric_trigger
   [junit4]   2> 
   [junit4]   2> 1235867 INFO  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker) [     ] 
o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:44687
   [junit4]   2> 1235868 INFO  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker) [     ] 
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:44687
   [junit4]   2> 1235868 INFO  
(SUITE-MetricTriggerIntegrationTest-seed#[474D9B647193201A]-worker) [     ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1 44687
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.MetricTriggerIntegrationTest_474D9B647193201A-001
   [junit4]   2> Mar 02, 2021 10:10:19 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene87): 
{_root_=Lucene84, id=PostingsFormat(name=Direct), x_s=Lucene84}, 
docValues:{_version_=DocValuesFormat(name=Asserting)}, 
maxPointsInLeafNode=1960, maxMBSortInHeap=5.087469259694917, 
sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=en-MT, 
timezone=Pacific/Marquesas
   [junit4]   2> NOTE: Linux 5.4.0-45-generic amd64/Oracle Corporation 
1.8.0_281 (64-bit)/cpus=4,threads=1,free=155100128,total=522190848
   [junit4]   2> NOTE: All tests run in this JVM: 
[TestPullReplicaErrorHandling, TestJoin, 
OverseerCollectionConfigSetProcessorTest, TestManagedSchemaThreadSafety, 
CdcrBootstrapTest, TestMergePolicyConfig, CustomCollectionTest, 
TestEmbeddedSolrServerAdminHandler, VersionInfoTest, StressHdfsTest, 
CdcrVersionReplicationTest, SuggestComponentContextFilterQueryTest, 
LoggingHandlerTest, XsltUpdateRequestHandlerTest, TestValueSourceCache, 
TestClusterProperties, SearchHandlerTest, CreateRoutedAliasTest, 
CategoryRoutedAliasUpdateProcessorTest, TestSimNodeLostTrigger, 
ResourceLoaderTest, TestHttpServletCarrier, TestLegacyField, 
DistribDocExpirationUpdateProcessorTest, DirectoryFactoriesTest, 
TestLegacyBM25SimilarityFactory, TaggingAttributeTest, TestUninvertingReader, 
SecurityHeadersTest, HighlighterMaxOffsetTest, TestFieldCacheReopen, 
DistributedFacetExistsSmallTest, TestRecoveryHdfs, HttpPartitionOnCommitTest, 
DateMathParserTest, AuditLoggerPluginTest, 
OverseerSolrResponseUnsafeSerializationTest, BJQFilterAccessibleTest, 
TestInPlaceUpdatesRequiredField, SystemInfoHandlerTest, PackageManagerCLITest, 
TestPivotHelperCode, SignificantTermsQParserPluginTest, 
TestUseDocValuesAsStored, TestFieldCollectionResource, PeerSyncTest, 
DocValuesNotIndexedTest, JavaBinAtomicUpdateMultivalueTest, QueryParsingTest, 
TestFieldCacheWithThreads, TestCloudDeleteByQuery, RankFieldTest, 
ByteBuffersDirectoryFactoryTest, TestShortCircuitedRequests, TestPackages, 
TestConfigSetsAPIZkFailure, TestDynamicLoading, PurgeGraphTest, 
TestStressVersions, TestSolrXml, TestSolrConfigHandlerCloud, 
HdfsLockFactoryTest, TestMultiValuedNumericRangeQuery, 
CollectionsAPIAsyncDistributedZkTest, AnalyticsQueryTest, 
HttpTriggerListenerTest, TestReplicaProperties, TestSolrConfigHandler, 
TestCoreContainer, HdfsThreadLeakTest, ZkNodePropsTest, TestDocSet, 
ZookeeperStatusHandlerTest, TestBackupRepositoryFactory, 
DocExpirationUpdateProcessorFactoryTest, TestCSVResponseWriter, 
SolrIndexConfigTest, ChangedSchemaMergeTest, CustomTermsComponentTest, 
TestFreeTextSuggestions, TestDFRSimilarityFactory, 
LeaderElectionIntegrationTest, ClusterStateTest, 
DistributedQueryComponentOptimizationTest, TestMinHashQParser, 
RequestLoggingTest, TriggerEventQueueTest, TestImpersonationWithHadoopAuth, 
TestJavabinTupleStreamParser, CloneFieldUpdateProcessorFactoryTest, 
TestManagedSynonymGraphFilterFactory, ProtectedTermFilterFactoryTest, 
TestMiniSolrCloudClusterSSL, TestCloudJSONFacetSKGEquiv, TestInfoStreamLogging, 
AssignBackwardCompatibilityTest, CollectionsAPISolrJTest, 
MetricTriggerIntegrationTest]
   [junit4] Completed [464/934 (1!)] on J1 in 36.91s, 1 test, 1 failure <<< 
FAILURES!

[...truncated 52262 lines...]
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:634:
 The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:507:
 The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/build.xml:494:
 Source checkout is dirty (unversioned/missing files) after running tests!!! 
Offending files:
* solr/contrib/analytics/src/test-files/solr/filestore
* solr/contrib/analytics/src/test-files/solr/userfiles
* 
solr/contrib/dataimporthandler-extras/src/test-files/dihextras/solr/collection1/conf/dataimport.properties
* solr/contrib/dataimporthandler-extras/src/test-files/dihextras/solr/filestore
* solr/contrib/dataimporthandler-extras/src/test-files/dihextras/solr/userfiles
* solr/contrib/dataimporthandler/src/test-files/dih/solr/filestore
* solr/contrib/dataimporthandler/src/test-files/dih/solr/userfiles
* solr/contrib/extraction/src/test-files/extraction/solr/filestore
* solr/contrib/extraction/src/test-files/extraction/solr/userfiles
* solr/contrib/langid/src/test-files/langid/solr/filestore
* solr/contrib/langid/src/test-files/langid/solr/userfiles
* solr/contrib/ltr/src/test-files/solr/filestore
* solr/contrib/ltr/src/test-files/solr/userfiles
* solr/contrib/prometheus-exporter/src/test-files/solr/filestore
* solr/contrib/prometheus-exporter/src/test-files/solr/userfiles
* solr/contrib/velocity/src/test-files/velocity/solr/filestore
* solr/contrib/velocity/src/test-files/velocity/solr/userfiles
* solr/core/src/test-files/solr/filestore
* solr/core/src/test-files/solr/userfiles
* solr/solrj/src/test-files/solrj/solr/multicore/filestore
* solr/solrj/src/test-files/solrj/solr/multicore/userfiles

Total time: 73 minutes 13 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to