Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/8846/
Java: 64bit/jdk-15-ea+16 -XX:-UseCompressedOops -XX:+UseG1GC

2 tests failed.
FAILED:  
org.apache.solr.cloud.autoscaling.sim.TestSimScenario.testAutoAddReplicas

Error Message:
OverseerTriggerThread never caught up to the latest znodeVersion

Stack Trace:
java.util.concurrent.TimeoutException: OverseerTriggerThread never caught up to 
the latest znodeVersion
        at 
__randomizedtesting.SeedInfo.seed([BF0A11639F233FB7:36AAE21FEB28F39E]:0)
        at org.apache.solr.util.TimeOut.waitFor(TimeOut.java:66)
        at 
org.apache.solr.cloud.autoscaling.sim.SimScenario$LoadAutoscaling.execute(SimScenario.java:466)
        at 
org.apache.solr.cloud.autoscaling.sim.SimScenario.run(SimScenario.java:1110)
        at 
org.apache.solr.cloud.autoscaling.sim.TestSimScenario.testAutoAddReplicas(TestSimScenario.java:58)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:564)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:942)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:978)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:819)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:470)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:951)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
        at java.base/java.lang.Thread.run(Thread.java:832)


FAILED:  
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest.testScheduledTrigger

Error Message:
ScheduledTrigger did not fire in time

Stack Trace:
java.lang.AssertionError: ScheduledTrigger did not fire in time
        at 
__randomizedtesting.SeedInfo.seed([BF0A11639F233FB7:2C115911C1DE6483]:0)
        at org.junit.Assert.fail(Assert.java:88)
        at org.junit.Assert.assertTrue(Assert.java:41)
        at 
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest.testScheduledTrigger(ScheduledTriggerIntegrationTest.java:120)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:564)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:942)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:978)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:819)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:470)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:951)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
        at java.base/java.lang.Thread.run(Thread.java:832)




Build Log:
[...truncated 14585 lines...]
   [junit4] Suite: 
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest
   [junit4]   2> 1152648 INFO  
(SUITE-ScheduledTriggerIntegrationTest-seed#[BF0A11639F233FB7]-worker) [     ] 
o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to 
test-framework derived value of 
'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\server\solr\configsets\_default\conf'
   [junit4]   2> 1152648 INFO  
(SUITE-ScheduledTriggerIntegrationTest-seed#[BF0A11639F233FB7]-worker) [     ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 1152649 INFO  
(SUITE-ScheduledTriggerIntegrationTest-seed#[BF0A11639F233FB7]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_BF0A11639F233FB7-001\data-dir-75-001
   [junit4]   2> 1152649 WARN  
(SUITE-ScheduledTriggerIntegrationTest-seed#[BF0A11639F233FB7]-worker) [     ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=78 numCloses=78
   [junit4]   2> 1152649 INFO  
(SUITE-ScheduledTriggerIntegrationTest-seed#[BF0A11639F233FB7]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 1152650 INFO  
(SUITE-ScheduledTriggerIntegrationTest-seed#[BF0A11639F233FB7]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 1152652 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.SolrTestCaseJ4 ###Starting testScheduledTrigger
   [junit4]   2> 1152652 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_BF0A11639F233FB7-001\tempDir-001
   [junit4]   2> 1152652 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1152653 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
   [junit4]   2> 1152653 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 1152752 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.c.ZkTestServer start zk server on port: 54546
   [junit4]   2> 1152752 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:54546
   [junit4]   2> 1152752 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:54546
   [junit4]   2> 1152752 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 54546
   [junit4]   2> 1152760 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1152764 INFO  (zkConnectionManagerCallback-9464-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1152764 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1152771 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1152773 INFO  (zkConnectionManagerCallback-9466-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1152774 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1152775 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1152779 INFO  (zkConnectionManagerCallback-9468-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1152779 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1152882 INFO  (jetty-launcher-9469-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1152882 INFO  (jetty-launcher-9469-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1152882 INFO  (jetty-launcher-9469-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 1152882 INFO  (jetty-launcher-9469-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 1152882 INFO  (jetty-launcher-9469-thread-2) [     ] 
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: 
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 15-ea+16-681
   [junit4]   2> 1152882 INFO  (jetty-launcher-9469-thread-1) [     ] 
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: 
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 15-ea+16-681
   [junit4]   2> 1152883 INFO  (jetty-launcher-9469-thread-1) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1152883 INFO  (jetty-launcher-9469-thread-1) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1152883 INFO  (jetty-launcher-9469-thread-1) [     ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 1152883 INFO  (jetty-launcher-9469-thread-2) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1152883 INFO  (jetty-launcher-9469-thread-2) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1152883 INFO  (jetty-launcher-9469-thread-2) [     ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 1152884 INFO  (jetty-launcher-9469-thread-1) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@3093908b{/solr,null,AVAILABLE}
   [junit4]   2> 1152884 INFO  (jetty-launcher-9469-thread-2) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@188c01c0{/solr,null,AVAILABLE}
   [junit4]   2> 1152885 INFO  (jetty-launcher-9469-thread-1) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@3f61e8e5{HTTP/1.1, (http/1.1, 
h2c)}{127.0.0.1:54561}
   [junit4]   2> 1152885 INFO  (jetty-launcher-9469-thread-1) [     ] 
o.e.j.s.Server Started @1106866ms
   [junit4]   2> 1152885 INFO  (jetty-launcher-9469-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=54561}
   [junit4]   2> 1152885 ERROR (jetty-launcher-9469-thread-1) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1152885 INFO  (jetty-launcher-9469-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1152888 INFO  (jetty-launcher-9469-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
9.0.0
   [junit4]   2> 1152888 INFO  (jetty-launcher-9469-thread-2) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@102e391f{HTTP/1.1, (http/1.1, 
h2c)}{127.0.0.1:54562}
   [junit4]   2> 1152888 INFO  (jetty-launcher-9469-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1152888 INFO  (jetty-launcher-9469-thread-2) [     ] 
o.e.j.s.Server Started @1106867ms
   [junit4]   2> 1152888 INFO  (jetty-launcher-9469-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr
   [junit4]   2> 1152888 INFO  (jetty-launcher-9469-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-05-18T06:42:12.427618400Z
   [junit4]   2> 1152888 INFO  (jetty-launcher-9469-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=54562}
   [junit4]   2> 1152888 ERROR (jetty-launcher-9469-thread-2) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1152888 INFO  (jetty-launcher-9469-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1152888 INFO  (jetty-launcher-9469-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
9.0.0
   [junit4]   2> 1152888 INFO  (jetty-launcher-9469-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1152888 INFO  (jetty-launcher-9469-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr
   [junit4]   2> 1152888 INFO  (jetty-launcher-9469-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-05-18T06:42:12.427618400Z
   [junit4]   2> 1152889 INFO  (jetty-launcher-9469-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1152889 INFO  (jetty-launcher-9469-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1152892 INFO  (zkConnectionManagerCallback-9471-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1152892 INFO  (jetty-launcher-9469-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1152892 INFO  (zkConnectionManagerCallback-9473-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1152892 INFO  (jetty-launcher-9469-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1152892 INFO  (jetty-launcher-9469-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1152892 INFO  (jetty-launcher-9469-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1152998 INFO  (jetty-launcher-9469-thread-1) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 1152998 WARN  (jetty-launcher-9469-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@68309219[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1152998 WARN  (jetty-launcher-9469-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@68309219[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1153003 WARN  (jetty-launcher-9469-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@401b3586[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1153003 WARN  (jetty-launcher-9469-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@401b3586[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1153004 INFO  (jetty-launcher-9469-thread-1) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:54546/solr
   [junit4]   2> 1153005 INFO  (jetty-launcher-9469-thread-1) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 1153007 INFO  (zkConnectionManagerCallback-9484-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1153007 INFO  (jetty-launcher-9469-thread-1) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 1153098 INFO  (jetty-launcher-9469-thread-2) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 1153099 WARN  (jetty-launcher-9469-thread-2) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@4e7967d0[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1153099 WARN  (jetty-launcher-9469-thread-2) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@4e7967d0[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1153100 INFO  (jetty-launcher-9469-thread-1) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:54561_solr
   [junit4]   2> 1153101 INFO  (jetty-launcher-9469-thread-1) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.Overseer Overseer 
(id=72062679140204549-127.0.0.1:54561_solr-n_0000000000) starting
   [junit4]   2> 1153103 WARN  (jetty-launcher-9469-thread-2) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@6106ee2e[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1153103 WARN  (jetty-launcher-9469-thread-2) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@6106ee2e[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1153103 INFO  (jetty-launcher-9469-thread-2) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:54546/solr
   [junit4]   2> 1153104 INFO  (jetty-launcher-9469-thread-2) 
[n:127.0.0.1:54562_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 1153106 INFO  (zkConnectionManagerCallback-9497-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1153106 INFO  (jetty-launcher-9469-thread-2) 
[n:127.0.0.1:54562_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 1153107 INFO  
(OverseerStateUpdate-72062679140204549-127.0.0.1:54561_solr-n_0000000000) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:54561_solr
   [junit4]   2> 1153107 INFO  (jetty-launcher-9469-thread-1) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:54561_solr
   [junit4]   2> 1153107 DEBUG 
(OverseerAutoScalingTriggerThread-72062679140204549-127.0.0.1:54561_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and 
.scheduled_maintenance triggers
   [junit4]   2> 1153108 INFO  
(OverseerStateUpdate-72062679140204549-127.0.0.1:54561_solr-n_0000000000) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1153108 DEBUG 
(OverseerAutoScalingTriggerThread-72062679140204549-127.0.0.1:54561_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with 
znode version 1
   [junit4]   2> 1153110 DEBUG 
(OverseerAutoScalingTriggerThread-72062679140204549-127.0.0.1:54561_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, 
lastZnodeVersion 0
   [junit4]   2> 1153110 DEBUG 
(OverseerAutoScalingTriggerThread-72062679140204549-127.0.0.1:54561_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto 
znodeVersion 1
   [junit4]   2> 1153110 INFO  (jetty-launcher-9469-thread-1) 
[n:127.0.0.1:54561_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 1153110 WARN  (jetty-launcher-9469-thread-1) 
[n:127.0.0.1:54561_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> 1153112 INFO  (jetty-launcher-9469-thread-2) 
[n:127.0.0.1:54562_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1153114 DEBUG 
(OverseerAutoScalingTriggerThread-72062679140204549-127.0.0.1:54561_solr-n_0000000000)
 [     ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial 
livenodes: [127.0.0.1:54561_solr]
   [junit4]   2> 1153114 DEBUG 
(OverseerAutoScalingTriggerThread-72062679140204549-127.0.0.1:54561_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / 
nodeAdded markers
   [junit4]   2> 1153114 DEBUG (ScheduledTrigger-9500-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> 1153116 DEBUG 
(OverseerAutoScalingTriggerThread-72062679140204549-127.0.0.1:54561_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, 
lastZnodeVersion 1
   [junit4]   2> 1153116 INFO  (jetty-launcher-9469-thread-2) 
[n:127.0.0.1:54562_solr     ] o.a.s.c.ZkController Publish 
node=127.0.0.1:54562_solr as DOWN
   [junit4]   2> 1153116 INFO  (jetty-launcher-9469-thread-2) 
[n:127.0.0.1:54562_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 1000 transient cores
   [junit4]   2> 1153116 INFO  (jetty-launcher-9469-thread-2) 
[n:127.0.0.1:54562_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:54562_solr
   [junit4]   2> 1153116 INFO  (zkCallback-9483-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1153120 INFO  (zkCallback-9496-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1153121 INFO  (jetty-launcher-9469-thread-2) 
[n:127.0.0.1:54562_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 1153121 WARN  (jetty-launcher-9469-thread-2) 
[n:127.0.0.1:54562_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> 1153137 INFO  (jetty-launcher-9469-thread-1) 
[n:127.0.0.1:54561_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1153145 INFO  (jetty-launcher-9469-thread-2) 
[n:127.0.0.1:54562_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1153162 INFO  (jetty-launcher-9469-thread-1) 
[n:127.0.0.1:54561_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_54561.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7c121f9
   [junit4]   2> 1153169 INFO  (jetty-launcher-9469-thread-1) 
[n:127.0.0.1:54561_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_54561.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7c121f9
   [junit4]   2> 1153169 INFO  (jetty-launcher-9469-thread-1) 
[n:127.0.0.1:54561_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_54561.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7c121f9
   [junit4]   2> 1153169 INFO  (jetty-launcher-9469-thread-2) 
[n:127.0.0.1:54562_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_54562.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7c121f9
   [junit4]   2> 1153171 INFO  (jetty-launcher-9469-thread-1) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_BF0A11639F233FB7-001\tempDir-001\node1\.
   [junit4]   2> 1153175 INFO  (jetty-launcher-9469-thread-2) 
[n:127.0.0.1:54562_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_54562.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7c121f9
   [junit4]   2> 1153175 INFO  (jetty-launcher-9469-thread-2) 
[n:127.0.0.1:54562_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_54562.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7c121f9
   [junit4]   2> 1153176 INFO  (jetty-launcher-9469-thread-2) 
[n:127.0.0.1:54562_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_BF0A11639F233FB7-001\tempDir-001\node2\.
   [junit4]   2> 1153213 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2
   [junit4]   2> 1153213 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1153216 INFO  (zkConnectionManagerCallback-9520-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1153216 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1153218 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 1153219 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 
127.0.0.1:54546/solr ready
   [junit4]   2> 1153226 INFO  (qtp518640818-14359) [n:127.0.0.1:54562_solr     
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling 
params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 1153235 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr     
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=2
   [junit4]   2> 1153240 INFO  (qtp518640818-14357) [n:127.0.0.1:54562_solr     
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=3
   [junit4]   2> 1153240 DEBUG (qtp518640818-14349) [n:127.0.0.1:54562_solr     
] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1153241 INFO  (qtp518640818-14349) [n:127.0.0.1:54562_solr     
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling 
params={wt=javabin&version=2} status=0 QTime=11
   [junit4]   2> 1153241 DEBUG (zkCallback-9483-thread-1) [     ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
2
   [junit4]   2> 1153241 DEBUG 
(OverseerAutoScalingTriggerThread-72062679140204549-127.0.0.1:54561_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto 
znodeVersion 2
   [junit4]   2> 1153243 INFO  (qtp518640818-14363) [n:127.0.0.1:54562_solr     
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
pullReplicas=0&maxShardsPerNode=5&name=testScheduledTrigger&nrtReplicas=3&action=CREATE&numShards=1&tlogReplicas=0&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1153243 DEBUG 
(OverseerAutoScalingTriggerThread-72062679140204549-127.0.0.1:54561_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / 
nodeAdded markers
   [junit4]   2> 1153244 DEBUG 
(OverseerAutoScalingTriggerThread-72062679140204549-127.0.0.1:54561_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, 
lastZnodeVersion 2
   [junit4]   2> 1153245 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
testScheduledTrigger
   [junit4]   2> 1153246 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/managed-schema to 
/configs/testScheduledTrigger.AUTOCREATED/managed-schema
   [junit4]   2> 1153247 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/protwords.txt to 
/configs/testScheduledTrigger.AUTOCREATED/protwords.txt
   [junit4]   2> 1153249 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/contractions_it.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/contractions_it.txt
   [junit4]   2> 1153250 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/contractions_ca.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/contractions_ca.txt
   [junit4]   2> 1153252 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stemdict_nl.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stemdict_nl.txt
   [junit4]   2> 1153253 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_hy.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_hy.txt
   [junit4]   2> 1153254 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_no.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_no.txt
   [junit4]   2> 1153256 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_id.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_id.txt
   [junit4]   2> 1153257 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_et.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_et.txt
   [junit4]   2> 1153259 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_da.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_da.txt
   [junit4]   2> 1153260 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ga.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_ga.txt
   [junit4]   2> 1153262 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_hi.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_hi.txt
   [junit4]   2> 1153263 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ja.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_ja.txt
   [junit4]   2> 1153265 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_pt.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_pt.txt
   [junit4]   2> 1153266 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_hu.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_hu.txt
   [junit4]   2> 1153268 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_el.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_el.txt
   [junit4]   2> 1153269 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ru.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_ru.txt
   [junit4]   2> 1153270 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_tr.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_tr.txt
   [junit4]   2> 1153272 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ar.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_ar.txt
   [junit4]   2> 1153272 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/userdict_ja.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/userdict_ja.txt
   [junit4]   2> 1153272 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_eu.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_eu.txt
   [junit4]   2> 1153276 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_it.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_it.txt
   [junit4]   2> 1153277 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_cz.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_cz.txt
   [junit4]   2> 1153279 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stoptags_ja.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stoptags_ja.txt
   [junit4]   2> 1153280 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/contractions_fr.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/contractions_fr.txt
   [junit4]   2> 1153281 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_de.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_de.txt
   [junit4]   2> 1153283 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_fa.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_fa.txt
   [junit4]   2> 1153284 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/contractions_ga.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/contractions_ga.txt
   [junit4]   2> 1153286 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ca.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_ca.txt
   [junit4]   2> 1153287 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_nl.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_nl.txt
   [junit4]   2> 1153289 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_bg.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_bg.txt
   [junit4]   2> 1153290 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_en.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_en.txt
   [junit4]   2> 1153296 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_es.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_es.txt
   [junit4]   2> 1153297 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_lv.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_lv.txt
   [junit4]   2> 1153300 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_ro.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_ro.txt
   [junit4]   2> 1153302 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_th.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_th.txt
   [junit4]   2> 1153303 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_fr.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_fr.txt
   [junit4]   2> 1153305 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_sv.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_sv.txt
   [junit4]   2> 1153306 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_fi.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_fi.txt
   [junit4]   2> 1153307 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/hyphenations_ga.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/hyphenations_ga.txt
   [junit4]   2> 1153309 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/lang/stopwords_gl.txt to 
/configs/testScheduledTrigger.AUTOCREATED/lang/stopwords_gl.txt
   [junit4]   2> 1153310 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/solrconfig.xml to 
/configs/testScheduledTrigger.AUTOCREATED/solrconfig.xml
   [junit4]   2> 1153311 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/synonyms.txt to 
/configs/testScheduledTrigger.AUTOCREATED/synonyms.txt
   [junit4]   2> 1153313 INFO  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/stopwords.txt to 
/configs/testScheduledTrigger.AUTOCREATED/stopwords.txt
   [junit4]   2> 1153416 WARN  
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.a.c.CreateCollectionCmd Specified number 
of replicas of 3 on collection testScheduledTrigger is higher than the number 
of Solr instances currently live or live and part of your createNodeSet(2). 
It's unusual to run two replica of the same slice on the same Solr-instance.
   [junit4]   2> 1153416 DEBUG 
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.s.c.a.PolicyHelper Creating a new session
   [junit4]   2> 1153420 INFO  (qtp518640818-14357) [n:127.0.0.1:54562_solr     
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=2
   [junit4]   2> 1153423 INFO  (qtp832962721-14362) [n:127.0.0.1:54561_solr     
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=2
   [junit4]   2> 1153423 DEBUG 
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.s.c.a.PolicyHelper New session created 
   [junit4]   2> 1153424 INFO  (qtp518640818-14349) [n:127.0.0.1:54562_solr     
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=2
   [junit4]   2> 1153428 INFO  (qtp832962721-14356) [n:127.0.0.1:54561_solr     
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=2
   [junit4]   2> 1153430 DEBUG 
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.s.c.a.PolicyHelper returnSession, 
curr-time 77593287 sessionWrapper.createTime 77593279620400, 
this.sessionWrapper.createTime 77593279620400 
   [junit4]   2> 1153433 INFO  
(OverseerStateUpdate-72062679140204549-127.0.0.1:54561_solr-n_0000000000) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testScheduledTrigger",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"testScheduledTrigger_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:54561/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:54561_solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1153439 INFO  
(OverseerStateUpdate-72062679140204549-127.0.0.1:54561_solr-n_0000000000) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testScheduledTrigger",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"testScheduledTrigger_shard1_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:54562/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:54562_solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1153443 INFO  
(OverseerStateUpdate-72062679140204549-127.0.0.1:54561_solr-n_0000000000) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"testScheduledTrigger",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"testScheduledTrigger_shard1_replica_n5",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:54562/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:54562_solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1153643 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr    
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core 
create command 
qt=/admin/cores&coreNodeName=core_node3&collection.configName=testScheduledTrigger.AUTOCREATED&newCollection=true&name=testScheduledTrigger_shard1_replica_n1&action=CREATE&numShards=1&collection=testScheduledTrigger&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1153643 INFO  (qtp518640818-14359) [n:127.0.0.1:54562_solr    
x:testScheduledTrigger_shard1_replica_n5 ] o.a.s.h.a.CoreAdminOperation core 
create command 
qt=/admin/cores&coreNodeName=core_node6&collection.configName=testScheduledTrigger.AUTOCREATED&newCollection=true&name=testScheduledTrigger_shard1_replica_n5&action=CREATE&numShards=1&collection=testScheduledTrigger&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1153643 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr    
x:testScheduledTrigger_shard1_replica_n1 ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 1000 
transient cores
   [junit4]   2> 1153643 INFO  (qtp518640818-14349) [n:127.0.0.1:54562_solr    
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.h.a.CoreAdminOperation core 
create command 
qt=/admin/cores&coreNodeName=core_node4&collection.configName=testScheduledTrigger.AUTOCREATED&newCollection=true&name=testScheduledTrigger_shard1_replica_n2&action=CREATE&numShards=1&collection=testScheduledTrigger&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1153662 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene 
MatchVersion: 9.0.0
   [junit4]   2> 1153662 INFO  (qtp518640818-14349) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node4 
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.c.SolrConfig Using Lucene 
MatchVersion: 9.0.0
   [junit4]   2> 1153662 INFO  (qtp518640818-14359) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node6 
x:testScheduledTrigger_shard1_replica_n5 ] o.a.s.c.SolrConfig Using Lucene 
MatchVersion: 9.0.0
   [junit4]   2> 1153700 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema 
name=default-config
   [junit4]   2> 1153700 INFO  (qtp518640818-14359) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node6 
x:testScheduledTrigger_shard1_replica_n5 ] o.a.s.s.IndexSchema Schema 
name=default-config
   [junit4]   2> 1153703 INFO  (qtp518640818-14349) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node4 
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.s.IndexSchema Schema 
name=default-config
   [junit4]   2> 1154011 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema 
default-config/1.6 with uniqueid field id
   [junit4]   2> 1154011 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating 
SolrCore 'testScheduledTrigger_shard1_replica_n1' using configuration from 
configset testScheduledTrigger.AUTOCREATED, trusted=true
   [junit4]   2> 1154011 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX 
monitoring for 'solr_54561.solr.core.testScheduledTrigger.shard1.replica_n1' 
(registry 'solr.core.testScheduledTrigger.shard1.replica_n1') enabled at 
server: com.sun.jmx.mbeanserver.JmxMBeanServer@7c121f9
   [junit4]   2> 1154011 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.SolrCore 
[[testScheduledTrigger_shard1_replica_n1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_BF0A11639F233FB7-001\tempDir-001\node1\.\testScheduledTrigger_shard1_replica_n1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_BF0A11639F233FB7-001\tempDir-001\node1\.\testScheduledTrigger_shard1_replica_n1\data\]
   [junit4]   2> 1154015 INFO  (qtp518640818-14359) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node6 
x:testScheduledTrigger_shard1_replica_n5 ] o.a.s.s.IndexSchema Loaded schema 
default-config/1.6 with uniqueid field id
   [junit4]   2> 1154015 INFO  (qtp518640818-14359) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node6 
x:testScheduledTrigger_shard1_replica_n5 ] o.a.s.c.CoreContainer Creating 
SolrCore 'testScheduledTrigger_shard1_replica_n5' using configuration from 
configset testScheduledTrigger.AUTOCREATED, trusted=true
   [junit4]   2> 1154016 INFO  (qtp518640818-14359) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node6 
x:testScheduledTrigger_shard1_replica_n5 ] o.a.s.m.r.SolrJmxReporter JMX 
monitoring for 'solr_54562.solr.core.testScheduledTrigger.shard1.replica_n5' 
(registry 'solr.core.testScheduledTrigger.shard1.replica_n5') enabled at 
server: com.sun.jmx.mbeanserver.JmxMBeanServer@7c121f9
   [junit4]   2> 1154016 INFO  (qtp518640818-14359) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node6 
x:testScheduledTrigger_shard1_replica_n5 ] o.a.s.c.SolrCore 
[[testScheduledTrigger_shard1_replica_n5] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_BF0A11639F233FB7-001\tempDir-001\node2\.\testScheduledTrigger_shard1_replica_n5],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_BF0A11639F233FB7-001\tempDir-001\node2\.\testScheduledTrigger_shard1_replica_n5\data\]
   [junit4]   2> 1154033 INFO  (qtp518640818-14349) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node4 
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.s.IndexSchema Loaded schema 
default-config/1.6 with uniqueid field id
   [junit4]   2> 1154033 INFO  (qtp518640818-14349) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node4 
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.c.CoreContainer Creating 
SolrCore 'testScheduledTrigger_shard1_replica_n2' using configuration from 
configset testScheduledTrigger.AUTOCREATED, trusted=true
   [junit4]   2> 1154038 INFO  (qtp518640818-14349) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node4 
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter JMX 
monitoring for 'solr_54562.solr.core.testScheduledTrigger.shard1.replica_n2' 
(registry 'solr.core.testScheduledTrigger.shard1.replica_n2') enabled at 
server: com.sun.jmx.mbeanserver.JmxMBeanServer@7c121f9
   [junit4]   2> 1154039 INFO  (qtp518640818-14349) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node4 
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.c.SolrCore 
[[testScheduledTrigger_shard1_replica_n2] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_BF0A11639F233FB7-001\tempDir-001\node2\.\testScheduledTrigger_shard1_replica_n2],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledTriggerIntegrationTest_BF0A11639F233FB7-001\tempDir-001\node2\.\testScheduledTrigger_shard1_replica_n2\data\]
   [junit4]   2> 1154113 DEBUG (ScheduledTrigger-9500-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> 1154413 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using 
UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1154413 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing 
UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1154425 INFO  (qtp518640818-14359) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node6 
x:testScheduledTrigger_shard1_replica_n5 ] o.a.s.u.UpdateHandler Using 
UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1154425 INFO  (qtp518640818-14359) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node6 
x:testScheduledTrigger_shard1_replica_n5 ] o.a.s.u.UpdateLog Initializing 
UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1154428 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard 
AutoCommit: if uncommitted for 15000ms; 
   [junit4]   2> 1154428 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 1154432 INFO  (qtp518640818-14359) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node6 
x:testScheduledTrigger_shard1_replica_n5 ] o.a.s.u.CommitTracker Hard 
AutoCommit: if uncommitted for 15000ms; 
   [junit4]   2> 1154432 INFO  (qtp518640818-14359) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node6 
x:testScheduledTrigger_shard1_replica_n5 ] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 1154441 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage 
Configured ZooKeeperStorageIO with znodeBase: 
/configs/testScheduledTrigger.AUTOCREATED
   [junit4]   2> 1154443 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage 
Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/testScheduledTrigger.AUTOCREATED
   [junit4]   2> 1154443 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Creating 
ZooKeeper watch for the managed schema at 
/configs/testScheduledTrigger.AUTOCREATED/managed-schema
   [junit4]   2> 1154443 INFO  (qtp518640818-14359) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node6 
x:testScheduledTrigger_shard1_replica_n5 ] o.a.s.r.ManagedResourceStorage 
Configured ZooKeeperStorageIO with znodeBase: 
/configs/testScheduledTrigger.AUTOCREATED
   [junit4]   2> 1154443 INFO  (qtp518640818-14359) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node6 
x:testScheduledTrigger_shard1_replica_n5 ] o.a.s.r.ManagedResourceStorage 
Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/testScheduledTrigger.AUTOCREATED
   [junit4]   2> 1154443 INFO  (qtp518640818-14359) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node6 
x:testScheduledTrigger_shard1_replica_n5 ] o.a.s.s.ZkIndexSchemaReader Creating 
ZooKeeper watch for the managed schema at 
/configs/testScheduledTrigger.AUTOCREATED/managed-schema
   [junit4]   2> 1154444 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Current 
schema version 0 is already the latest
   [junit4]   2> 1154445 INFO  (qtp518640818-14349) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node4 
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.u.UpdateHandler Using 
UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1154445 INFO  (qtp518640818-14349) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node4 
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.u.UpdateLog Initializing 
UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1154445 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.h.c.SpellCheckComponent 
Initializing spell checkers
   [junit4]   2> 1154445 INFO  (qtp518640818-14359) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node6 
x:testScheduledTrigger_shard1_replica_n5 ] o.a.s.s.ZkIndexSchemaReader Current 
schema version 0 is already the latest
   [junit4]   2> 1154445 INFO  (qtp518640818-14359) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node6 
x:testScheduledTrigger_shard1_replica_n5 ] o.a.s.h.c.SpellCheckComponent 
Initializing spell checkers
   [junit4]   2> 1154447 INFO  (qtp518640818-14349) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node4 
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.u.CommitTracker Hard 
AutoCommit: if uncommitted for 15000ms; 
   [junit4]   2> 1154447 INFO  (qtp518640818-14349) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node4 
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 1154450 INFO  (qtp518640818-14349) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node4 
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.r.ManagedResourceStorage 
Configured ZooKeeperStorageIO with znodeBase: 
/configs/testScheduledTrigger.AUTOCREATED
   [junit4]   2> 1154451 INFO  (qtp518640818-14349) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node4 
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.r.ManagedResourceStorage 
Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/testScheduledTrigger.AUTOCREATED
   [junit4]   2> 1154451 INFO  (qtp518640818-14349) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node4 
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.s.ZkIndexSchemaReader Creating 
ZooKeeper watch for the managed schema at 
/configs/testScheduledTrigger.AUTOCREATED/managed-schema
   [junit4]   2> 1154451 INFO  (qtp518640818-14349) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node4 
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.s.ZkIndexSchemaReader Current 
schema version 0 is already the latest
   [junit4]   2> 1154451 INFO  (qtp518640818-14349) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node4 
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.h.c.SpellCheckComponent 
Initializing spell checkers
   [junit4]   2> 1154455 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.s.DirectSolrSpellChecker init: 
{name=default, field=_text_, classname=solr.DirectSolrSpellChecker, 
distanceMeasure=internal, accuracy=0.5, maxEdits=2, minPrefix=1, 
maxInspections=5, minQueryLength=4, maxQueryFrequency=0.01}
   [junit4]   2> 1154456 INFO  (qtp518640818-14359) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node6 
x:testScheduledTrigger_shard1_replica_n5 ] o.a.s.s.DirectSolrSpellChecker init: 
{name=default, field=_text_, classname=solr.DirectSolrSpellChecker, 
distanceMeasure=internal, accuracy=0.5, maxEdits=2, minPrefix=1, 
maxInspections=5, minQueryLength=4, maxQueryFrequency=0.01}
   [junit4]   2> 1154461 INFO  (qtp518640818-14349) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node4 
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.s.DirectSolrSpellChecker init: 
{name=default, field=_text_, classname=solr.DirectSolrSpellChecker, 
distanceMeasure=internal, accuracy=0.5, maxEdits=2, minPrefix=1, 
maxInspections=5, minQueryLength=4, maxQueryFrequency=0.01}
   [junit4]   2> 1154463 INFO  (qtp518640818-14359) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node6 
x:testScheduledTrigger_shard1_replica_n5 ] o.a.s.h.ReplicationHandler Commits 
will be reserved for 10000 ms
   [junit4]   2> 1154463 INFO  (qtp518640818-14359) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node6 
x:testScheduledTrigger_shard1_replica_n5 ] o.a.s.u.UpdateLog Could not find max 
version in index or recent updates, using new clock 1667009488095281152
   [junit4]   2> 1154463 INFO  (qtp518640818-14349) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node4 
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.h.ReplicationHandler Commits 
will be reserved for 10000 ms
   [junit4]   2> 1154463 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits 
will be reserved for 10000 ms
   [junit4]   2> 1154464 INFO  (qtp518640818-14349) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node4 
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.u.UpdateLog Could not find max 
version in index or recent updates, using new clock 1667009488096329728
   [junit4]   2> 1154464 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max 
version in index or recent updates, using new clock 1667009488096329728
   [junit4]   2> 1154466 INFO  
(searcherExecutor-9522-thread-1-processing-n:127.0.0.1:54561_solr 
x:testScheduledTrigger_shard1_replica_n1 c:testScheduledTrigger s:shard1 
r:core_node3) [n:127.0.0.1:54561_solr c:testScheduledTrigger s:shard1 
r:core_node3 x:testScheduledTrigger_shard1_replica_n1 ] 
o.a.s.c.QuerySenderListener QuerySenderListener done.
   [junit4]   2> 1154466 INFO  
(searcherExecutor-9522-thread-1-processing-n:127.0.0.1:54561_solr 
x:testScheduledTrigger_shard1_replica_n1 c:testScheduledTrigger s:shard1 
r:core_node3) [n:127.0.0.1:54561_solr c:testScheduledTrigger s:shard1 
r:core_node3 x:testScheduledTrigger_shard1_replica_n1 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1154466 INFO  
(searcherExecutor-9524-thread-1-processing-n:127.0.0.1:54562_solr 
x:testScheduledTrigger_shard1_replica_n5 c:testScheduledTrigger s:shard1 
r:core_node6) [n:127.0.0.1:54562_solr c:testScheduledTrigger s:shard1 
r:core_node6 x:testScheduledTrigger_shard1_replica_n5 ] 
o.a.s.c.QuerySenderListener QuerySenderListener done.
   [junit4]   2> 1154466 INFO  
(searcherExecutor-9524-thread-1-processing-n:127.0.0.1:54562_solr 
x:testScheduledTrigger_shard1_replica_n5 c:testScheduledTrigger s:shard1 
r:core_node6) [n:127.0.0.1:54562_solr c:testScheduledTrigger s:shard1 
r:core_node6 x:testScheduledTrigger_shard1_replica_n5 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1154467 INFO  
(searcherExecutor-9526-thread-1-processing-n:127.0.0.1:54562_solr 
x:testScheduledTrigger_shard1_replica_n2 c:testScheduledTrigger s:shard1 
r:core_node4) [n:127.0.0.1:54562_solr c:testScheduledTrigger s:shard1 
r:core_node4 x:testScheduledTrigger_shard1_replica_n2 ] 
o.a.s.c.QuerySenderListener QuerySenderListener done.
   [junit4]   2> 1154467 INFO  
(searcherExecutor-9526-thread-1-processing-n:127.0.0.1:54562_solr 
x:testScheduledTrigger_shard1_replica_n2 c:testScheduledTrigger s:shard1 
r:core_node4) [n:127.0.0.1:54562_solr c:testScheduledTrigger s:shard1 
r:core_node4 x:testScheduledTrigger_shard1_replica_n2 ] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1154468 INFO  
(searcherExecutor-9522-thread-1-processing-n:127.0.0.1:54561_solr 
x:testScheduledTrigger_shard1_replica_n1 c:testScheduledTrigger s:shard1 
r:core_node3) [n:127.0.0.1:54561_solr c:testScheduledTrigger s:shard1 
r:core_node3 x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.SolrCore 
[testScheduledTrigger_shard1_replica_n1]  Registered new searcher autowarm 
time: 0 ms: Collection: 'testScheduledTrigger'
   [junit4]   2> 1154468 INFO  
(searcherExecutor-9524-thread-1-processing-n:127.0.0.1:54562_solr 
x:testScheduledTrigger_shard1_replica_n5 c:testScheduledTrigger s:shard1 
r:core_node6) [n:127.0.0.1:54562_solr c:testScheduledTrigger s:shard1 
r:core_node6 x:testScheduledTrigger_shard1_replica_n5 ] o.a.s.c.SolrCore 
[testScheduledTrigger_shard1_replica_n5]  Registered new searcher autowarm 
time: 0 ms: Collection: 'testScheduledTrigger'
   [junit4]   2> 1154471 INFO  
(searcherExecutor-9526-thread-1-processing-n:127.0.0.1:54562_solr 
x:testScheduledTrigger_shard1_replica_n2 c:testScheduledTrigger s:shard1 
r:core_node4) [n:127.0.0.1:54562_solr c:testScheduledTrigger s:shard1 
r:core_node4 x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.c.SolrCore 
[testScheduledTrigger_shard1_replica_n2]  Registered new searcher autowarm 
time: 0 ms: Collection: 'testScheduledTrigger'
   [junit4]   2> 1154471 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful 
update of terms at /collections/testScheduledTrigger/terms/shard1 to 
Terms{values={core_node3=0}, version=0}
   [junit4]   2> 1154471 INFO  (qtp518640818-14359) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node6 
x:testScheduledTrigger_shard1_replica_n5 ] o.a.s.c.ZkShardTerms Failed to save 
terms, version is not a match, retrying
   [junit4]   2> 1154471 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/testScheduledTrigger/leaders/shard1
   [junit4]   2> 1154474 INFO  (qtp518640818-14359) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node6 
x:testScheduledTrigger_shard1_replica_n5 ] o.a.s.c.ZkShardTerms Successful 
update of terms at /collections/testScheduledTrigger/terms/shard1 to 
Terms{values={core_node6=0, core_node3=0}, version=1}
   [junit4]   2> 1154474 INFO  (qtp518640818-14359) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node6 
x:testScheduledTrigger_shard1_replica_n5 ] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/testScheduledTrigger/leaders/shard1
   [junit4]   2> 1154474 INFO  (qtp518640818-14349) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node4 
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.c.ZkShardTerms Successful 
update of terms at /collections/testScheduledTrigger/terms/shard1 to 
Terms{values={core_node6=0, core_node3=0, core_node4=0}, version=2}
   [junit4]   2> 1154474 INFO  (qtp518640818-14349) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node4 
x:testScheduledTrigger_shard1_replica_n2 ] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/testScheduledTrigger/leaders/shard1
   [junit4]   2> 1154478 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext 
Enough replicas found to continue.
   [junit4]   2> 1154478 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I 
may be the new leader - try and sync
   [junit4]   2> 1154478 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas 
to http://127.0.0.1:54561/solr/testScheduledTrigger_shard1_replica_n1/
   [junit4]   2> 1154478 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.u.PeerSync PeerSync: 
core=testScheduledTrigger_shard1_replica_n1 url=http://127.0.0.1:54561/solr  
START 
replicas=[http://127.0.0.1:54562/solr/testScheduledTrigger_shard1_replica_n2/, 
http://127.0.0.1:54562/solr/testScheduledTrigger_shard1_replica_n5/] 
nUpdates=100
   [junit4]   2> 1154481 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.u.PeerSync PeerSync: 
core=testScheduledTrigger_shard1_replica_n1 url=http://127.0.0.1:54561/solr  
DONE. We have no versions. sync failed.
   [junit4]   2> 1154483 INFO  (qtp518640818-14357) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node6 
x:testScheduledTrigger_shard1_replica_n5 ] o.a.s.c.S.Request 
[testScheduledTrigger_shard1_replica_n5]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1154483 INFO  (qtp518640818-14426) [n:127.0.0.1:54562_solr 
c:testScheduledTrigger s:shard1 r:core_node4 
x:testScheduledTrigger_shard1_replica_n2 ] o.a.s.c.S.Request 
[testScheduledTrigger_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> 1154483 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.SyncStrategy Leader's 
attempt to sync with shard failed, moving to the next candidate
   [junit4]   2> 1154483 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_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> 1154483 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/testScheduledTrigger/leaders/shard1/leader after winning as 
/collections/testScheduledTrigger/leader_elect/shard1/election/72062679140204549-core_node3-n_0000000000
   [junit4]   2> 1154497 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I 
am the new leader: 
http://127.0.0.1:54561/solr/testScheduledTrigger_shard1_replica_n1/ shard1
   [junit4]   2> 1154603 INFO  (zkCallback-9483-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testScheduledTrigger/state.json] for collection 
[testScheduledTrigger] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1154603 INFO  (zkCallback-9483-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testScheduledTrigger/state.json] for collection 
[testScheduledTrigger] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1154608 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr 
c:testScheduledTrigger s:shard1 r:core_node3 
x:testScheduledTrigger_shard1_replica_n1 ] o.a.s.c.ZkController I am the 
leader, no recovery necessary
   [junit4]   2> 1154611 INFO  (qtp832962721-14358) [n:127.0.0.1:54561_solr     
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=testScheduledTrigger.AUTOCREATED&newCollection=true&name=testScheduledTrigger_shard1_replica_n1&action=CREATE&numShards=1&collection=testScheduledTrigger&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=986
   [junit4]   2> 1154709 INFO  (zkCallback-9483-thread-3) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testScheduledTrigger/state.json] for collection 
[testScheduledTrigger] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1154709 INFO  (zkCallback-9483-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testScheduledTrigger/state.json] for collection 
[testScheduledTrigger] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1154709 INFO  (zkCallback-9483-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testScheduledTrigger/state.json] for collection 
[testScheduledTrigger] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1155229 DEBUG (ScheduledTrigger-9500-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> 1155473 INFO  (qtp518640818-14349) [n:127.0.0.1:54562_solr     
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=testScheduledTrigger.AUTOCREATED&newCollection=true&name=testScheduledTrigger_shard1_replica_n2&action=CREATE&numShards=1&collection=testScheduledTrigger&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1859
   [junit4]   2> 1155474 INFO  (qtp518640818-14359) [n:127.0.0.1:54562_solr     
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node6&collection.configName=testScheduledTrigger.AUTOCREATED&newCollection=true&name=testScheduledTrigger_shard1_replica_n5&action=CREATE&numShards=1&collection=testScheduledTrigger&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1860
   [junit4]   2> 1155474 DEBUG 
(OverseerThreadFactory-9504-thread-1-processing-n:127.0.0.1:54561_solr) 
[n:127.0.0.1:54561_solr     ] o.a.s.c.s.c.a.PolicyHelper session set to NULL
   [junit4]   2> 1155476 INFO  (qtp518640818-14363) [n:127.0.0.1:54562_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> 1155572 INFO  (zkCallback-9483-thread-4) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testScheduledTrigger/state.json] for collection 
[testScheduledTrigger] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1155572 INFO  (zkCallback-9483-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testScheduledTrigger/state.json] for collection 
[testScheduledTrigger] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1155572 INFO  (zkCallback-9496-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testScheduledTrigger/state.json] for collection 
[testScheduledTrigger] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1155572 INFO  (zkCallback-9483-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testScheduledTrigger/state.json] for collection 
[testScheduledTrigger] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1155572 INFO  (zkCallback-9496-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/testScheduledTrigger/state.json] for collection 
[testScheduledTrigger] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1155572 INFO  (qtp518640818-14363) [n:127.0.0.1:54562_solr     
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={pullReplicas=0&maxShardsPerNode=5&name=testScheduledTrigger&nrtReplicas=3&action=CREATE&numShards=1&tlogReplicas=0&wt=javabin&version=2}
 status=0 QTime=2367
   [junit4]   2> 1155573 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection: 
testScheduledTrigger
   [junit4]   2> 1155576 INFO  (qtp518640818-14357) [n:127.0.0.1:54562_solr     
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={wt=javabin&version=2&key=solr.core.testScheduledTrigger.shard1.replica_n5:INDEX.sizeInBytes&key=solr.core.testScheduledTrigger.shard1.replica_n2:INDEX.sizeInBytes}
 status=0 QTime=0
   [junit4]   2> 1155579 INFO  (qtp518640818-14349) [n:127.0.0.1:54562_solr     
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=2
   [junit4]   2> 1155579 INFO  (qtp832962721-14360) [n:127.0.0.1:54561_solr     
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={wt=javabin&version=2&key=solr.core.testScheduledTrigger.shard1.replica_n1:INDEX.sizeInBytes}
 status=0 QTime=0
   [junit4]   2> 1155581 INFO  (qtp832962721-14362) [n:127.0.0.1:54561_solr     
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=2
   [junit4]   2> 1155583 DEBUG (qtp518640818-14426) [n:127.0.0.1:54562_solr     
] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1155583 INFO  (qtp518640818-14426) [n:127.0.0.1:54562_solr     
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling 
params={wt=javabin&version=2} status=0 QTime=9
   [junit4]   2> 1155584 DEBUG (zkCallback-9483-thread-1) [     ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
3
   [junit4]   2> 1155584 DEBUG 
(OverseerAutoScalingTriggerThread-72062679140204549-127.0.0.1:54561_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto 
znodeVersion 3
   [junit4]   2> 1155585 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding 
port=0)
   [junit4]   2> 1155585 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 
2 ...
   [junit4]   2> 1155585 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 
2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 
15-ea+16-681
   [junit4]   2> 1155585 DEBUG 
(OverseerAutoScalingTriggerThread-72062679140204549-127.0.0.1:54561_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / 
nodeAdded markers
   [junit4]   2> 1155586 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1155586 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1155586 DEBUG 
(OverseerAutoScalingTriggerThread-72062679140204549-127.0.0.1:54561_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3, 
lastZnodeVersion 3
   [junit4]   2> 1155586 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1155586 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@2e99ba55{/solr,null,AVAILABLE}
   [junit4]   2> 1155587 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.e.j.s.AbstractConnector Started ServerConnector@7da153ad{HTTP/1.1, 
(http/1.1, h2c)}{127.0.0.1:54722}
   [junit4]   2> 1155587 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.e.j.s.Server Started @1109610ms
   [junit4]   2> 1155587 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=54722}
   [junit4]   2> 1155588 ERROR 
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 1155588 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1155588 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ 
version 9.0.0
   [junit4]   2> 1155588 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on 
port null
   [junit4]   2> 1155588 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr
   [junit4]   2> 1155588 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-05-18T06:42:15.127739100Z
   [junit4]   2> 1155589 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1155592 INFO  (zkConnectionManagerCallback-9540-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1155592 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1155593 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1155700 INFO  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 1155701 WARN  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@6ad7d669[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1155701 WARN  
(TEST-ScheduledTriggerIntegrationTest.testScheduledTrigger-seed#[BF0A11639F233FB7])
 [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm 
configured for Client@6ad7d669[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1155706 WARN  (TEST-Sc

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

a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 100 and last live nodes: 100
   [junit4]   2> 1574133 DEBUG (ScheduledTrigger-13868-thread-3) [     ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 100 and last live nodes: 100
   [junit4]   2> 1574160 DEBUG (ScheduledTrigger-13868-thread-1) [     ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 100 and last live nodes: 100
   [junit4]   2> 1574186 DEBUG (ScheduledTrigger-13868-thread-2) [     ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 100 and last live nodes: 100
   [junit4]   2> 1574212 DEBUG (ScheduledTrigger-13868-thread-3) [     ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 100 and last live nodes: 100
   [junit4]   2> 1574241 DEBUG (ScheduledTrigger-13868-thread-4) [     ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 100 and last live nodes: 100
   [junit4]   2> 1574270 DEBUG (ScheduledTrigger-13868-thread-1) [     ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 100 and last live nodes: 100
   [junit4]   2> 1574297 DEBUG (ScheduledTrigger-13868-thread-2) [     ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 100 and last live nodes: 100
   [junit4]   2> 1574305 INFO  
(TEST-TestSimScenario.testIndexing-seed#[BF0A11639F233FB7]) [     ] 
o.a.s.c.a.s.SimScenario 9.   WaitEvent       trigger=indexSizeTrigger&wait=60
   [junit4]   2> 1574305 INFO  
(TEST-TestSimScenario.testIndexing-seed#[BF0A11639F233FB7]) [     ] 
o.a.s.c.a.s.SimScenario              WaitEvent       
trigger=indexSizeTrigger&wait=60
   [junit4]   2> 1574306 INFO  
(TEST-TestSimScenario.testIndexing-seed#[BF0A11639F233FB7]) [     ] 
o.a.s.c.a.s.SimScenario 10.  Assert  
condition=not_null&key=_trigger_event_indexSizeTrigger
   [junit4]   2> 1574306 INFO  
(TEST-TestSimScenario.testIndexing-seed#[BF0A11639F233FB7]) [     ] 
o.a.s.c.a.s.SimScenario              Assert  
condition=not_null&key=_trigger_event_indexSizeTrigger
   [junit4]   2> 1574308 INFO  
(TEST-TestSimScenario.testIndexing-seed#[BF0A11639F233FB7]) [     ] 
o.a.s.c.a.s.SimScenario 11.  Assert  
condition=equals&key=_trigger_event_indexSizeTrigger/eventType&expected=INDEXSIZE
   [junit4]   2> 1574308 INFO  
(TEST-TestSimScenario.testIndexing-seed#[BF0A11639F233FB7]) [     ] 
o.a.s.c.a.s.SimScenario              Assert  
condition=equals&key=_trigger_event_indexSizeTrigger/eventType&expected=INDEXSIZE
   [junit4]   2> 1574308 INFO  
(TEST-TestSimScenario.testIndexing-seed#[BF0A11639F233FB7]) [     ] 
o.a.s.c.a.s.SimScenario 12.  Assert  
condition=equals&key=_trigger_event_indexSizeTrigger/properties/requestedOps[0]/action&expected=SPLITSHARD
   [junit4]   2> 1574308 INFO  
(TEST-TestSimScenario.testIndexing-seed#[BF0A11639F233FB7]) [     ] 
o.a.s.c.a.s.SimScenario              Assert  
condition=equals&key=_trigger_event_indexSizeTrigger/properties/requestedOps[0]/action&expected=SPLITSHARD
   [junit4]   2> 1574308 INFO  
(TEST-TestSimScenario.testIndexing-seed#[BF0A11639F233FB7]) [     ] 
o.a.s.c.a.s.SimScenario 13.  WaitCollection  
collection=testCollection&shards=6&withInactive=true&requireLeaders=false&replicas=2
   [junit4]   2> 1574308 INFO  
(TEST-TestSimScenario.testIndexing-seed#[BF0A11639F233FB7]) [     ] 
o.a.s.c.a.s.SimScenario              WaitCollection  
collection=testCollection&shards=6&withInactive=true&requireLeaders=false&replicas=2
   [junit4]   2> 1574309 DEBUG 
(TEST-TestSimScenario.testIndexing-seed#[BF0A11639F233FB7]) [     ] 
o.a.s.c.a.ScheduledTriggers Shutting down scheduled thread pool executor now
   [junit4]   2> 1574309 DEBUG 
(TEST-TestSimScenario.testIndexing-seed#[BF0A11639F233FB7]) [     ] 
o.a.s.c.a.ScheduledTriggers Shutting down action executor now
   [junit4]   2> 1574309 DEBUG 
(TEST-TestSimScenario.testIndexing-seed#[BF0A11639F233FB7]) [     ] 
o.a.s.c.a.ScheduledTriggers Awaiting termination for action executor
   [junit4]   2> 1574309 INFO  (Simulated OverseerAutoScalingTriggerThread) [   
  ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are 
closed, exiting.
   [junit4]   2> 1574309 DEBUG 
(TEST-TestSimScenario.testIndexing-seed#[BF0A11639F233FB7]) [     ] 
o.a.s.c.a.ScheduledTriggers Awaiting termination for scheduled thread pool 
executor
   [junit4]   2> 1574309 DEBUG 
(TEST-TestSimScenario.testIndexing-seed#[BF0A11639F233FB7]) [     ] 
o.a.s.c.a.ScheduledTriggers ScheduledTriggers closed completely
   [junit4]   2> 1574309 DEBUG 
(TEST-TestSimScenario.testIndexing-seed#[BF0A11639F233FB7]) [     ] 
o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
   [junit4]   2> 1574310 INFO  
(TEST-TestSimScenario.testIndexing-seed#[BF0A11639F233FB7]) [     ] 
o.a.s.SolrTestCaseJ4 ###Ending testIndexing
   [junit4]   2> NOTE: leaving temporary files on disk at: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J2\temp\solr.cloud.autoscaling.sim.TestSimScenario_BF0A11639F233FB7-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene84): {}, 
docValues:{}, maxPointsInLeafNode=1640, maxMBSortInHeap=5.1878191589133085, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@2cebec57),
 locale=fr-CG, timezone=Africa/Lome
   [junit4]   2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 15-ea 
(64-bit)/cpus=6,threads=1,free=171752136,total=392167424
   [junit4]   2> NOTE: All tests run in this JVM: [HighlighterConfigTest, 
DistributedUpdateProcessorTest, TestLRUStatsCache, TestFoldingMultitermQuery, 
QueryParsingTest, TestElisionMultitermQuery, TemplateUpdateProcessorTest, 
TestDirectoryFactory, TestJsonRangeFacets, TestCloudSchemaless, 
SolrSlf4jReporterTest, TestBlobHandler, TestCodecSupport, 
JavaBinAtomicUpdateMultivalueTest, TestManagedSynonymFilterFactory, 
HdfsRestartWhileUpdatingTest, OverseerModifyCollectionTest, TestCrossCoreJoin, 
TestNoOpRegenerator, NestedShardedAtomicUpdateTest, LeaderElectionTest, 
TestUnifiedSolrHighlighter, TestSubQueryTransformerCrossCore, 
TestFieldResource, LegacyCloudClusterPropTest, TestReplicationHandler, 
DistributedQueryComponentOptimizationTest, 
DistributedFacetSimpleRefinementLongTailTest, MinimalSchemaTest, 
TestSolrQueryResponse, XMLAtomicUpdateMultivalueTest, TestCloudRecovery2, 
OverseerTaskQueueTest, TestLegacyTerms, TestSolrCloudWithHadoopAuthPlugin, 
CheckHdfsIndexTest, TestJsonFacetErrors, TestDocTermOrds, TestSimpleTextCodec, 
TestMacroExpander, ConfigureRecoveryStrategyTest, 
TestExternalRoleRuleBasedAuthorizationPlugin, TestUseDocValuesAsStored2, 
CoreAdminRequestStatusTest, FacetPivotSmallTest, CdcrVersionReplicationTest, 
TestNumericTerms64, SolrCLIZkUtilsTest, TestSolrXml, SaslZkACLProviderTest, 
DeleteStatusTest, DeleteInactiveReplicaTest, TestTermsQParserPlugin, 
CdcrBidirectionalTest, BasicAuthStandaloneTest, 
HdfsCollectionsAPIDistributedZkTest, HdfsChaosMonkeyNothingIsSafeTest, 
TestSchemaSimilarityResource, MetricsHistoryHandlerTest, TestStressRecovery, 
TestSizeLimitedDistributedMap, TestAtomicUpdateErrorCases, 
TestCollectionsAPIViaSolrCloudCluster, SolrMetricReporterTest, TestJsonRequest, 
TestComplexPhraseLeadingWildcard, TestSimGenericDistributedQueue, 
TestDownShardTolerantSearch, RecoveryZkTest, TestRandomFaceting, TestUtils, 
HdfsWriteToMultipleCollectionsTest, 
ClassificationUpdateProcessorIntegrationTest, CursorMarkTest, 
TestLegacyBM25SimilarityFactory, ZkCLITest, ConvertedLegacyTest, 
ChaosMonkeySafeLeaderWithPullReplicasTest, FileBasedSpellCheckerTest, 
TestCloudInspectUtil, TestSolrJ, ZkStateWriterTest, DocValuesMissingTest, 
TestTolerantUpdateProcessorCloud, DistanceUnitsTest, 
TestPullReplicaErrorHandling, TestCollectionAPIs, SortSpecParsingTest, 
TestSystemCollAutoCreate, AnalysisAfterCoreReloadTest, BasicFunctionalityTest, 
DistributedIntervalFacetingTest, TestSolrTestCaseJ4, TestTolerantSearch, 
PathHierarchyTokenizerFactoryTest, ProtectedTermFilterFactoryTest, 
TestReversedWildcardFilterFactory, TokenizerChainTest, 
TestLuceneIndexBackCompat, AliasIntegrationTest, BasicZkTest, 
ChaosMonkeyNothingIsSafeTest, CloudExitableDirectoryReaderTest, 
ClusterStateMockUtilTest, ClusterStateTest, ClusterStateUpdateTest, 
CollectionPropsTest, ConnectionManagerTest, DeleteShardTest, 
DistributedVersionInfoTest, HttpPartitionOnCommitTest, ReplicationFactorTest, 
TestStressInPlaceUpdates, AssignTest, CollectionReloadTest, 
CollectionsAPIDistributedZkTest, IndexSizeTriggerMixedBoundsTest, 
NodeMarkersRegistrationTest, TestPolicyCloud, TestSimExecutePlanAction, 
TestSimNodeLostTrigger, TestSimScenario]
   [junit4] Completed [597/912 (2!)] on J2 in 6.54s, 4 tests, 1 error <<< 
FAILURES!

[...truncated 45951 lines...]
[repro] Jenkins log URL: 
https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/8846/consoleText

[repro] Revision: 06df50e759a8edf2315dc421a5b12570577471a3

[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseG1GC"

[repro] JUnit rest result XML files will be moved to: ./repro-reports
[repro] ant clean

[...truncated 6 lines...]
[repro] Test suites by module:
[repro]    solr\core
[repro]       ScheduledTriggerIntegrationTest
[repro]       TestSimScenario
[repro] ant compile-test

[...truncated 3156 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=10 
-Dtests.class="*.ScheduledTriggerIntegrationTest|*.TestSimScenario" 
-Dtests.showOutput=onerror "-Dargs=-XX:-UseCompressedOops -XX:+UseG1GC" 
-Dtests.seed=BF0A11639F233FB7 -Dtests.slow=true -Dtests.locale=kk 
-Dtests.timezone=Indian/Mahe -Dtests.asserts=true -Dtests.file.encoding=Cp1252

[...truncated 117 lines...]
[repro] Failures w/original seeds:
[repro]   0/5 failed: 
org.apache.solr.cloud.autoscaling.ScheduledTriggerIntegrationTest
[repro]   0/5 failed: org.apache.solr.cloud.autoscaling.sim.TestSimScenario
[repro] Exiting with code 0

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

Reply via email to