Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/21597/
Java: 64bit/jdk-9.0.4 -XX:+UseCompressedOops -XX:+UseG1GC

3 tests failed.
FAILED:  
org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest.testInactiveShardCleanup

Error Message:
should be at least one inactive event

Stack Trace:
java.lang.AssertionError: should be at least one inactive event
        at 
__randomizedtesting.SeedInfo.seed([25F4CC897CAC5672:38D80CFB1DEF7179]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at 
org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest.testInactiveShardCleanup(ScheduledMaintenanceTriggerTest.java:218)
        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:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.base/java.lang.Thread.run(Thread.java:844)


FAILED:  
org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest.testInactiveShardCleanup

Error Message:
should be at least one inactive event

Stack Trace:
java.lang.AssertionError: should be at least one inactive event
        at 
__randomizedtesting.SeedInfo.seed([25F4CC897CAC5672:38D80CFB1DEF7179]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at 
org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest.testInactiveShardCleanup(ScheduledMaintenanceTriggerTest.java:218)
        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:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.base/java.lang.Thread.run(Thread.java:844)


FAILED:  
org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest.testInactiveShardCleanup

Error Message:
cleanup action didn't run

Stack Trace:
java.lang.AssertionError: cleanup action didn't run
        at 
__randomizedtesting.SeedInfo.seed([25F4CC897CAC5672:38D80CFB1DEF7179]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at 
org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest.testInactiveShardCleanup(ScheduledMaintenanceTriggerTest.java:197)
        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:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.base/java.lang.Thread.run(Thread.java:844)




Build Log:
[...truncated 13161 lines...]
   [junit4] Suite: 
org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest_25F4CC897CAC5672-001/init-core-data-001
   [junit4]   2> 868561 WARN  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[25F4CC897CAC5672]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
   [junit4]   2> 868561 INFO  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[25F4CC897CAC5672]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 868561 INFO  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[25F4CC897CAC5672]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 868562 INFO  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[25F4CC897CAC5672]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 868562 INFO  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[25F4CC897CAC5672]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest_25F4CC897CAC5672-001/tempDir-001
   [junit4]   2> 868562 INFO  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[25F4CC897CAC5672]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 868562 INFO  (Thread-5227) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 868562 INFO  (Thread-5227) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 868564 ERROR (Thread-5227) [    ] o.a.z.s.ZooKeeperServer 
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action 
on ERROR or SHUTDOWN server state changes
   [junit4]   2> 868662 INFO  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[25F4CC897CAC5672]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:39893
   [junit4]   2> 868664 INFO  (zkConnectionManagerCallback-3749-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 868667 INFO  (jetty-launcher-3746-thread-1) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-21T17:27:37-04:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 868667 INFO  (jetty-launcher-3746-thread-1) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 868667 INFO  (jetty-launcher-3746-thread-1) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 868667 INFO  (jetty-launcher-3746-thread-1) [    ] 
o.e.j.s.session Scavenging every 660000ms
   [junit4]   2> 868668 INFO  (jetty-launcher-3746-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@7d000966{/solr,null,AVAILABLE}
   [junit4]   2> 868670 INFO  (jetty-launcher-3746-thread-1) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@42794f5c{SSL,[ssl, 
http/1.1]}{127.0.0.1:?????}
   [junit4]   2> 868670 INFO  (jetty-launcher-3746-thread-1) [    ] 
o.e.j.s.Server Started @??????ms
   [junit4]   2> 868670 INFO  (jetty-launcher-3746-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=40409}
   [junit4]   2> 868670 ERROR (jetty-launcher-3746-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 868670 INFO  (jetty-launcher-3746-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 868670 INFO  (jetty-launcher-3746-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 868670 INFO  (jetty-launcher-3746-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 868670 INFO  (jetty-launcher-3746-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-03-08T21:10:23.267670Z
   [junit4]   2> 868671 INFO  (zkConnectionManagerCallback-3751-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 868672 INFO  (jetty-launcher-3746-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 868677 INFO  (jetty-launcher-3746-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39893/solr
   [junit4]   2> 868678 INFO  (zkConnectionManagerCallback-3755-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 868679 INFO  
(zkConnectionManagerCallback-3757-thread-1-processing-n:127.0.0.1:40409_solr) 
[n:127.0.0.1:40409_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 868713 INFO  (jetty-launcher-3746-thread-1) 
[n:127.0.0.1:40409_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 868714 INFO  (jetty-launcher-3746-thread-1) 
[n:127.0.0.1:40409_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:40409_solr
   [junit4]   2> 868714 INFO  (jetty-launcher-3746-thread-1) 
[n:127.0.0.1:40409_solr    ] o.a.s.c.Overseer Overseer 
(id=72102226036654083-127.0.0.1:40409_solr-n_0000000000) starting
   [junit4]   2> 868717 INFO  (jetty-launcher-3746-thread-1) 
[n:127.0.0.1:40409_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:40409_solr
   [junit4]   2> 868717 DEBUG 
(OverseerAutoScalingTriggerThread-72102226036654083-127.0.0.1:40409_solr-n_0000000000)
 [n:127.0.0.1:40409_solr    ] o.a.s.c.a.OverseerTriggerThread Adding 
.auto_add_replicas and .scheduled_maintenance triggers
   [junit4]   2> 868717 INFO  
(OverseerStateUpdate-72102226036654083-127.0.0.1:40409_solr-n_0000000000) 
[n:127.0.0.1:40409_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 868717 DEBUG 
(OverseerAutoScalingTriggerThread-72102226036654083-127.0.0.1:40409_solr-n_0000000000)
 [n:127.0.0.1:40409_solr    ] o.a.s.c.a.OverseerTriggerThread Refreshing 
/autoscaling.json with znode version 1
   [junit4]   2> 868718 DEBUG 
(OverseerAutoScalingTriggerThread-72102226036654083-127.0.0.1:40409_solr-n_0000000000)
 [n:127.0.0.1:40409_solr    ] o.a.s.c.a.NodeLostTrigger Initial livenodes: 
[127.0.0.1:40409_solr]
   [junit4]   2> 868718 DEBUG 
(OverseerAutoScalingTriggerThread-72102226036654083-127.0.0.1:40409_solr-n_0000000000)
 [n:127.0.0.1:40409_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 1, lastZnodeVersion -1
   [junit4]   2> 868718 DEBUG 
(OverseerAutoScalingTriggerThread-72102226036654083-127.0.0.1:40409_solr-n_0000000000)
 [n:127.0.0.1:40409_solr    ] o.a.s.c.a.OverseerTriggerThread Processed trigger 
updates upto znodeVersion 1
   [junit4]   2> 868726 DEBUG 
(OverseerAutoScalingTriggerThread-72102226036654083-127.0.0.1:40409_solr-n_0000000000)
 [n:127.0.0.1:40409_solr    ] o.a.s.c.a.OverseerTriggerThread -- clean old 
nodeAdded markers
   [junit4]   2> 868726 DEBUG (ScheduledTrigger-3418-thread-1) 
[n:127.0.0.1:40409_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: 1
   [junit4]   2> 868726 DEBUG 
(OverseerAutoScalingTriggerThread-72102226036654083-127.0.0.1:40409_solr-n_0000000000)
 [n:127.0.0.1:40409_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 1, lastZnodeVersion 1
   [junit4]   2> 868751 INFO  (jetty-launcher-3746-thread-1) 
[n:127.0.0.1:40409_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_40409.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7615b0f7
   [junit4]   2> 868757 INFO  (jetty-launcher-3746-thread-1) 
[n:127.0.0.1:40409_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_40409.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7615b0f7
   [junit4]   2> 868758 INFO  (jetty-launcher-3746-thread-1) 
[n:127.0.0.1:40409_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_40409.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7615b0f7
   [junit4]   2> 868758 INFO  (jetty-launcher-3746-thread-1) 
[n:127.0.0.1:40409_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest_25F4CC897CAC5672-001/tempDir-001/node1/.
   [junit4]   2> 868767 INFO  (zkConnectionManagerCallback-3761-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 868769 INFO  (zkConnectionManagerCallback-3765-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 868770 INFO  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[25F4CC897CAC5672]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 868770 INFO  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[25F4CC897CAC5672]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:39893/solr ready
   [junit4]   2> 868772 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    
] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and 
.scheduled_maintenance triggers
   [junit4]   2> 868773 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    
] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode 
version 0
   [junit4]   2> 868773 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    
] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10006_solr]
   [junit4]   2> 868773 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion -1
   [junit4]   2> 868773 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    
] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 0
   [junit4]   2> 868774 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    
] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 868774 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion 0
   [junit4]   2> 868774 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 868776 INFO  
(TEST-ScheduledMaintenanceTriggerTest.testInactiveShardCleanup-seed#[25F4CC897CAC5672])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testInactiveShardCleanup
   [junit4]   2> 868795 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 868815 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 868835 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 868855 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 868875 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 868895 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 868916 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 868928 DEBUG (simCloudManagerPool-3424-thread-4) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for 
ScheduledMaintenanceTriggerTest_collection1 / shard1: {"core_node1":{
   [junit4]   2>     "node_name":"127.0.0.1:10006_solr",
   [junit4]   2>     
"core":"ScheduledMaintenanceTriggerTest_collection1_shard1_replica_n1",
   [junit4]   2>     "leader":"true",
   [junit4]   2>     "state":"active",
   [junit4]   2>     "type":"NRT",
   [junit4]   2>     "INDEX.sizeInBytes":1,
   [junit4]   2>     "shard":"shard1",
   [junit4]   2>     
"collection":"ScheduledMaintenanceTriggerTest_collection1"}}
   [junit4]   2> 868928 DEBUG (simCloudManagerPool-3424-thread-6) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for 
ScheduledMaintenanceTriggerTest_collection1 / shard1_0: {"core_node4":{
   [junit4]   2>     "node_name":"127.0.0.1:10006_solr",
   [junit4]   2>     "base_url":"http://127.0.0.1:10006/solr";,
   [junit4]   2>     "leader":"true",
   [junit4]   2>     "state":"active",
   [junit4]   2>     "type":"NRT",
   [junit4]   2>     "INDEX.sizeInBytes":1,
   [junit4]   2>     
"core":"ScheduledMaintenanceTriggerTest_collection1_shard1_0_replica0",
   [junit4]   2>     "shard":"shard1_0",
   [junit4]   2>     
"collection":"ScheduledMaintenanceTriggerTest_collection1"}}
   [junit4]   2> 868928 DEBUG (simCloudManagerPool-3424-thread-5) [    ] 
o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for 
ScheduledMaintenanceTriggerTest_collection1 / shard1_1: {"core_node5":{
   [junit4]   2>     "node_name":"127.0.0.1:10006_solr",
   [junit4]   2>     "base_url":"http://127.0.0.1:10006/solr";,
   [junit4]   2>     "leader":"true",
   [junit4]   2>     "state":"active",
   [junit4]   2>     "type":"NRT",
   [junit4]   2>     "INDEX.sizeInBytes":1,
   [junit4]   2>     
"core":"ScheduledMaintenanceTriggerTest_collection1_shard1_1_replica0",
   [junit4]   2>     "shard":"shard1_1",
   [junit4]   2>     
"collection":"ScheduledMaintenanceTriggerTest_collection1"}}
   [junit4]   2> 868930 DEBUG (simCloudManagerPool-3424-thread-7) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 868930 DEBUG (simCloudManagerPool-3424-thread-7) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
1
   [junit4]   2> 868930 DEBUG (simCloudManagerPool-3424-thread-7) [    ] 
o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10006_solr]
   [junit4]   2> 868930 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    
] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
   [junit4]   2> 868930 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    
] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 868931 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
   [junit4]   2> 868933 DEBUG (simCloudManagerPool-3424-thread-8) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 868933 DEBUG (simCloudManagerPool-3424-thread-8) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
2
   [junit4]   2> 868933 DEBUG (simCloudManagerPool-3424-thread-8) [    ] 
o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10006_solr]
   [junit4]   2> 868933 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    
] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2
   [junit4]   2> 868934 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    
] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 868934 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2
   [junit4]   2> 868934 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:10:25.370Z. Now: 2018-03-09T01:08:20.740Z
   [junit4]   2> 868934 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620773635aTerk317tvnwne2ps1lvw73kq11",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543425370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557700740},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 868936 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 868956 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 868957 WARN  (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:10:27.370Z. Now: 2018-03-09T01:08:21.896Z
   [junit4]   2> 868957 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207736b2aTerk317tvnwne2ps1lvw73kq13",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543427370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557701896},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 868976 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 868978 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:10:29.370Z. Now: 2018-03-09T01:08:22.932Z
   [junit4]   2> 868978 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"162077372faTerk317tvnwne2ps1lvw73kq15",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543429370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557702932},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 868996 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 868998 WARN  (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:10:31.370Z. Now: 2018-03-09T01:08:23.966Z
   [junit4]   2> 868998 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207737acaTerk317tvnwne2ps1lvw73kq17",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543431370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557703966},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869016 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869019 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:10:33.370Z. Now: 2018-03-09T01:08:24.990Z
   [junit4]   2> 869019 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620773829aTerk317tvnwne2ps1lvw73kq19",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543433370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557704990},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869037 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869039 WARN  (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:10:35.370Z. Now: 2018-03-09T01:08:26.025Z
   [junit4]   2> 869040 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207738a6aTerk317tvnwne2ps1lvw73kq1b",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543435370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557706025},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869057 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869060 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:10:37.370Z. Now: 2018-03-09T01:08:27.055Z
   [junit4]   2> 869060 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620773923aTerk317tvnwne2ps1lvw73kq1d",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543437370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557707055},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869077 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869081 WARN  (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:10:39.370Z. Now: 2018-03-09T01:08:28.093Z
   [junit4]   2> 869081 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207739a0aTerk317tvnwne2ps1lvw73kq1f",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543439370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557708093},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869097 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869102 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:10:41.370Z. Now: 2018-03-09T01:08:29.127Z
   [junit4]   2> 869102 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620773a1daTerk317tvnwne2ps1lvw73kq1h",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543441370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557709127},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869118 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869122 WARN  (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:10:43.370Z. Now: 2018-03-09T01:08:30.160Z
   [junit4]   2> 869122 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620773a9aaTerk317tvnwne2ps1lvw73kq1j",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543443370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557710160},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869138 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869143 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:10:45.370Z. Now: 2018-03-09T01:08:31.190Z
   [junit4]   2> 869143 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620773b17aTerk317tvnwne2ps1lvw73kq1l",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543445370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557711190},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869158 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869163 WARN  (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:10:47.370Z. Now: 2018-03-09T01:08:32.213Z
   [junit4]   2> 869163 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620773b94aTerk317tvnwne2ps1lvw73kq1n",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543447370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557712213},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869178 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869184 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:10:49.370Z. Now: 2018-03-09T01:08:33.253Z
   [junit4]   2> 869184 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620773c11aTerk317tvnwne2ps1lvw73kq1p",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543449370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557713253},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869198 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869205 WARN  (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:10:51.370Z. Now: 2018-03-09T01:08:34.293Z
   [junit4]   2> 869205 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620773c8eaTerk317tvnwne2ps1lvw73kq1r",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543451370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557714293},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869219 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869226 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:10:53.370Z. Now: 2018-03-09T01:08:35.336Z
   [junit4]   2> 869226 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620773d0baTerk317tvnwne2ps1lvw73kq1t",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543453370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557715336},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869239 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869246 WARN  (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:10:55.370Z. Now: 2018-03-09T01:08:36.373Z
   [junit4]   2> 869247 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620773d88aTerk317tvnwne2ps1lvw73kq1v",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543455370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557716373},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869259 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869267 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:10:57.370Z. Now: 2018-03-09T01:08:37.402Z
   [junit4]   2> 869267 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620773e05aTerk317tvnwne2ps1lvw73kq1x",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543457370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557717402},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869279 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869287 WARN  (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:10:59.370Z. Now: 2018-03-09T01:08:38.423Z
   [junit4]   2> 869288 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620773e82aTerk317tvnwne2ps1lvw73kq1z",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543459370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557718423},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869299 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869308 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:01.370Z. Now: 2018-03-09T01:08:39.456Z
   [junit4]   2> 869308 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620773effaTerk317tvnwne2ps1lvw73kq21",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543461370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557719456},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869320 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869329 WARN  (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:03.370Z. Now: 2018-03-09T01:08:40.492Z
   [junit4]   2> 869329 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620773f7caTerk317tvnwne2ps1lvw73kq23",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543463370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557720492},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869340 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869350 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:05.370Z. Now: 2018-03-09T01:08:41.528Z
   [junit4]   2> 869350 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620773ff9aTerk317tvnwne2ps1lvw73kq25",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543465370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557721528},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869360 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869371 WARN  (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:07.370Z. Now: 2018-03-09T01:08:42.580Z
   [junit4]   2> 869371 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620774076aTerk317tvnwne2ps1lvw73kq27",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543467370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557722580},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869380 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869391 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:09.370Z. Now: 2018-03-09T01:08:43.621Z
   [junit4]   2> 869392 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207740f3aTerk317tvnwne2ps1lvw73kq29",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543469370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557723621},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869401 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869412 WARN  (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:11.370Z. Now: 2018-03-09T01:08:44.657Z
   [junit4]   2> 869412 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620774170aTerk317tvnwne2ps1lvw73kq2b",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543471370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557724657},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869421 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869433 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:13.370Z. Now: 2018-03-09T01:08:45.706Z
   [junit4]   2> 869433 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207741edaTerk317tvnwne2ps1lvw73kq2d",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543473370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557725706},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869441 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869454 WARN  (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:15.370Z. Now: 2018-03-09T01:08:46.735Z
   [junit4]   2> 869454 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"162077426aaTerk317tvnwne2ps1lvw73kq2f",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543475370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557726735},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869461 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869475 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:17.370Z. Now: 2018-03-09T01:08:47.778Z
   [junit4]   2> 869475 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207742e7aTerk317tvnwne2ps1lvw73kq2h",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543477370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557727778},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869481 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869496 WARN  (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:19.370Z. Now: 2018-03-09T01:08:48.861Z
   [junit4]   2> 869496 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620774364aTerk317tvnwne2ps1lvw73kq2j",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543479370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557728861},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869502 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869519 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:21.370Z. Now: 2018-03-09T01:08:49.982Z
   [junit4]   2> 869519 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207743e1aTerk317tvnwne2ps1lvw73kq2l",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543481370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557729982},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869522 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869539 WARN  (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:23.370Z. Now: 2018-03-09T01:08:51.013Z
   [junit4]   2> 869539 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"162077445eaTerk317tvnwne2ps1lvw73kq2n",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543483370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557731013},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869542 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869561 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:25.370Z. Now: 2018-03-09T01:08:52.077Z
   [junit4]   2> 869561 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207744dbaTerk317tvnwne2ps1lvw73kq2p",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543485370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557732077},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869562 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869581 WARN  (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:27.370Z. Now: 2018-03-09T01:08:53.108Z
   [junit4]   2> 869581 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620774558aTerk317tvnwne2ps1lvw73kq2r",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543487370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557733108},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869582 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869602 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:29.370Z. Now: 2018-03-09T01:08:54.147Z
   [junit4]   2> 869602 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207745d5aTerk317tvnwne2ps1lvw73kq2t",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543489370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557734147},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869602 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869623 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869623 WARN  (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:31.370Z. Now: 2018-03-09T01:08:55.180Z
   [junit4]   2> 869623 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620774652aTerk317tvnwne2ps1lvw73kq2v",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543491370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557735180},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869643 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869643 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:33.370Z. Now: 2018-03-09T01:08:56.214Z
   [junit4]   2> 869643 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207746cfaTerk317tvnwne2ps1lvw73kq2x",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543493370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557736214},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869663 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869664 WARN  (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:35.370Z. Now: 2018-03-09T01:08:57.240Z
   [junit4]   2> 869664 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"162077474caTerk317tvnwne2ps1lvw73kq2z",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543495370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557737240},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869683 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869684 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:37.370Z. Now: 2018-03-09T01:08:58.270Z
   [junit4]   2> 869685 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207747c9aTerk317tvnwne2ps1lvw73kq31",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543497370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557738270},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869704 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869705 WARN  (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:39.370Z. Now: 2018-03-09T01:08:59.306Z
   [junit4]   2> 869705 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620774846aTerk317tvnwne2ps1lvw73kq33",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543499370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557739306},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869724 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869726 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:41.370Z. Now: 2018-03-09T01:09:00.346Z
   [junit4]   2> 869726 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207748c3aTerk317tvnwne2ps1lvw73kq35",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543501370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557740346},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869726 DEBUG (ScheduledTrigger-3418-thread-3) 
[n:127.0.0.1:40409_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: 1
   [junit4]   2> 869744 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869747 WARN  (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:43.370Z. Now: 2018-03-09T01:09:01.401Z
   [junit4]   2> 869747 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620774940aTerk317tvnwne2ps1lvw73kq37",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543503370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557741401},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869764 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869768 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:45.370Z. Now: 2018-03-09T01:09:02.442Z
   [junit4]   2> 869768 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207749bdaTerk317tvnwne2ps1lvw73kq39",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543505370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557742442},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869785 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869789 WARN  (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:47.370Z. Now: 2018-03-09T01:09:03.475Z
   [junit4]   2> 869789 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620774a3aaTerk317tvnwne2ps1lvw73kq3b",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543507370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557743475},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869805 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869809 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:49.370Z. Now: 2018-03-09T01:09:04.501Z
   [junit4]   2> 869809 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620774ab7aTerk317tvnwne2ps1lvw73kq3d",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543509370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557744501},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869825 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869829 WARN  (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:51.370Z. Now: 2018-03-09T01:09:05.523Z
   [junit4]   2> 869830 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620774b34aTerk317tvnwne2ps1lvw73kq3f",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543511370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557745523},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869845 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869850 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:53.370Z. Now: 2018-03-09T01:09:06.551Z
   [junit4]   2> 869850 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620774bb1aTerk317tvnwne2ps1lvw73kq3h",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543513370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557746551},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869865 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869871 WARN  (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:55.370Z. Now: 2018-03-09T01:09:07.585Z
   [junit4]   2> 869871 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620774c2eaTerk317tvnwne2ps1lvw73kq3j",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543515370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557747585},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869885 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869891 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:57.370Z. Now: 2018-03-09T01:09:08.621Z
   [junit4]   2> 869892 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620774cabaTerk317tvnwne2ps1lvw73kq3l",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543517370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557748621},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869906 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869912 WARN  (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:11:59.370Z. Now: 2018-03-09T01:09:09.652Z
   [junit4]   2> 869912 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620774d28aTerk317tvnwne2ps1lvw73kq3n",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543519370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557749652},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869926 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869933 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:12:01.370Z. Now: 2018-03-09T01:09:10.688Z
   [junit4]   2> 869933 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620774da5aTerk317tvnwne2ps1lvw73kq3p",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543521370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557750688},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869946 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869954 WARN  (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:12:03.370Z. Now: 2018-03-09T01:09:11.725Z
   [junit4]   2> 869954 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620774e22aTerk317tvnwne2ps1lvw73kq3r",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543523370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557751725},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869966 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869974 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:12:05.370Z. Now: 2018-03-09T01:09:12.758Z
   [junit4]   2> 869974 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620774e9faTerk317tvnwne2ps1lvw73kq3t",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543525370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557752758},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 869987 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 869995 WARN  (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:12:07.370Z. Now: 2018-03-09T01:09:13.796Z
   [junit4]   2> 869995 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620774f1caTerk317tvnwne2ps1lvw73kq3v",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543527370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557753796},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 870007 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 870016 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:12:09.370Z. Now: 2018-03-09T01:09:14.828Z
   [junit4]   2> 870016 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620774f99aTerk317tvnwne2ps1lvw73kq3x",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543529370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557754828},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 870027 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 870036 WARN  (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:12:11.370Z. Now: 2018-03-09T01:09:15.862Z
   [junit4]   2> 870036 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620775016aTerk317tvnwne2ps1lvw73kq3z",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543531370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557755862},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 870047 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 870057 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:12:13.370Z. Now: 2018-03-09T01:09:16.891Z
   [junit4]   2> 870057 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620775093aTerk317tvnwne2ps1lvw73kq41",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543533370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557756891},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 870067 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 870078 WARN  (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:12:15.370Z. Now: 2018-03-09T01:09:17.926Z
   [junit4]   2> 870078 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620775110aTerk317tvnwne2ps1lvw73kq43",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543535370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557757926},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 870087 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 870098 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:12:17.370Z. Now: 2018-03-09T01:09:18.964Z
   [junit4]   2> 870098 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"162077518daTerk317tvnwne2ps1lvw73kq45",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543537370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557758964},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 870108 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 870119 WARN  (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:12:19.370Z. Now: 2018-03-09T01:09:19.998Z
   [junit4]   2> 870119 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"162077520aaTerk317tvnwne2ps1lvw73kq47",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543539370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557759998},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 870128 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 870140 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:12:21.370Z. Now: 2018-03-09T01:09:21.034Z
   [junit4]   2> 870140 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620775287aTerk317tvnwne2ps1lvw73kq49",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543541370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557761034},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 870148 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 870160 WARN  (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:12:23.370Z. Now: 2018-03-09T01:09:22.062Z
   [junit4]   2> 870160 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620775304aTerk317tvnwne2ps1lvw73kq4b",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543543370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557762062},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 870168 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 870181 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:12:25.370Z. Now: 2018-03-09T01:09:23.090Z
   [junit4]   2> 870181 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620775381aTerk317tvnwne2ps1lvw73kq4d",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543545370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557763090},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 870189 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 870201 WARN  (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:12:27.370Z. Now: 2018-03-09T01:09:24.123Z
   [junit4]   2> 870202 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207753feaTerk317tvnwne2ps1lvw73kq4f",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543547370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557764123},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 870209 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 870222 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:12:29.370Z. Now: 2018-03-09T01:09:25.156Z
   [junit4]   2> 870222 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"162077547baTerk317tvnwne2ps1lvw73kq4h",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543549370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557765156},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 870229 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 870243 WARN  (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:12:31.370Z. Now: 2018-03-09T01:09:26.183Z
   [junit4]   2> 870243 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207754f8aTerk317tvnwne2ps1lvw73kq4j",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543551370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557766183},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 870249 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 870263 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:12:33.370Z. Now: 2018-03-09T01:09:27.214Z
   [junit4]   2> 870263 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620775575aTerk317tvnwne2ps1lvw73kq4l",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543553370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557767214},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 870269 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 870284 WARN  (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:12:35.370Z. Now: 2018-03-09T01:09:28.244Z
   [junit4]   2> 870284 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207755f2aTerk317tvnwne2ps1lvw73kq4n",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543555370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557768244},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 870289 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 870305 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:12:37.370Z. Now: 2018-03-09T01:09:29.276Z
   [junit4]   2> 870305 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"162077566faTerk317tvnwne2ps1lvw73kq4p",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543557370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557769276},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 870310 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 870325 WARN  (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:12:39.370Z. Now: 2018-03-09T01:09:30.320Z
   [junit4]   2> 870326 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207756ecaTerk317tvnwne2ps1lvw73kq4r",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543559370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557770320},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 870330 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 870346 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:12:41.370Z. Now: 2018-03-09T01:09:31.356Z
   [junit4]   2> 870346 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620775769aTerk317tvnwne2ps1lvw73kq4t",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543561370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557771356},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 870350 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 870367 WARN  (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:12:43.370Z. Now: 2018-03-09T01:09:32.387Z
   [junit4]   2> 870367 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207757e6aTerk317tvnwne2ps1lvw73kq4v",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543563370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557772387},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 870370 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 870387 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:12:45.370Z. Now: 2018-03-09T01:09:33.417Z
   [junit4]   2> 870387 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620775863aTerk317tvnwne2ps1lvw73kq4x",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543565370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557773417},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 870390 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 870408 WARN  (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:12:47.370Z. Now: 2018-03-09T01:09:34.453Z
   [junit4]   2> 870408 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207758e0aTerk317tvnwne2ps1lvw73kq4z",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543567370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557774453},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 870411 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 870428 WARN  (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:12:49.370Z. Now: 2018-03-09T01:09:35.469Z
   [junit4]   2> 870428 DEBUG (ScheduledTrigger-3425-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"162077595daTerk317tvnwne2ps1lvw73kq51",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543569370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557775469},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 870431 DEBUG (ScheduledTrigger-3425-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 870449 WARN  (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T21:12:51.370Z. Now: 2018-03-09T01:09:36.490Z
   [junit4]   2> 870449 DEBUG (ScheduledTrigger-3425-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207759daaTerk317tvnwne2ps1lvw73kq53",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520543571370,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520557776490},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 870451 DEBUG (ScheduledTrigger-3425-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [juni

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

o_add_replicas_plan",
   [junit4]   2>           "class":"solr.AutoAddReplicasPlanAction"},
   [junit4]   2>         {
   [junit4]   2>           "name":"execute_plan",
   [junit4]   2>           "class":"solr.ExecutePlanAction"}],
   [junit4]   2>       "enabled":true}},
   [junit4]   2>   "listeners":{
   [junit4]   2>     ".scheduled_maintenance.system":{
   [junit4]   2>       "trigger":".scheduled_maintenance",
   [junit4]   2>       "afterAction":[],
   [junit4]   2>       "stage":[
   [junit4]   2>         "STARTED",
   [junit4]   2>         "ABORTED",
   [junit4]   2>         "SUCCEEDED",
   [junit4]   2>         "FAILED",
   [junit4]   2>         "BEFORE_ACTION",
   [junit4]   2>         "AFTER_ACTION",
   [junit4]   2>         "IGNORED"],
   [junit4]   2>       
"class":"org.apache.solr.cloud.autoscaling.SystemLogListener",
   [junit4]   2>       "beforeAction":[]},
   [junit4]   2>     ".auto_add_replicas.system":{
   [junit4]   2>       "trigger":".auto_add_replicas",
   [junit4]   2>       "afterAction":[],
   [junit4]   2>       "stage":[
   [junit4]   2>         "STARTED",
   [junit4]   2>         "ABORTED",
   [junit4]   2>         "SUCCEEDED",
   [junit4]   2>         "FAILED",
   [junit4]   2>         "BEFORE_ACTION",
   [junit4]   2>         "AFTER_ACTION",
   [junit4]   2>         "IGNORED"],
   [junit4]   2>       
"class":"org.apache.solr.cloud.autoscaling.SystemLogListener",
   [junit4]   2>       "beforeAction":[]}},
   [junit4]   2>   "properties":{}}
   [junit4]   2> 6786 INFO  
(TEST-ScheduledMaintenanceTriggerTest.testTriggerDefaults-seed#[25F4CC897CAC5672])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testTriggerDefaults
   [junit4] OK      0.01s J1 | 
ScheduledMaintenanceTriggerTest.testTriggerDefaults
   [junit4]   2> 6787 WARN  (Simulated OverseerAutoScalingTriggerThread) [    ] 
o.a.s.c.a.OverseerTriggerThread Interrupted
   [junit4]   2> java.lang.InterruptedException
   [junit4]   2>        at 
java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2037)
   [junit4]   2>        at 
java.base/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2071)
   [junit4]   2>        at 
org.apache.solr.cloud.autoscaling.OverseerTriggerThread.run(OverseerTriggerThread.java:177)
   [junit4]   2>        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4]   2> 6788 DEBUG 
(SUITE-ScheduledMaintenanceTriggerTest-seed#[25F4CC897CAC5672]-worker) [    ] 
o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
   [junit4]   2> 6792 INFO  (jetty-closer-22-thread-1) [    ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@4aed400e{SSL,[ssl, 
http/1.1]}{127.0.0.1:?}
   [junit4]   2> 6792 INFO  (jetty-closer-22-thread-1) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1935957595
   [junit4]   2> 6792 INFO  (jetty-closer-22-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 6792 INFO  (jetty-closer-22-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@fdb7f41: rootName = 
solr_36225, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@74111532
   [junit4]   2> 6805 INFO  (jetty-closer-22-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 6805 INFO  (jetty-closer-22-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@214a0c17: rootName = 
solr_36225, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@30edbf5d
   [junit4]   2> 6813 INFO  (jetty-closer-22-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 6813 INFO  (jetty-closer-22-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@7bffd701: rootName = 
solr_36225, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@3b416131
   [junit4]   2> 6815 INFO  (jetty-closer-22-thread-1) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:36225_solr
   [junit4]   2> 6816 INFO  (jetty-closer-22-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 6816 INFO  (jetty-closer-22-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 6816 INFO  
(zkCallback-31-thread-1-processing-n:127.0.0.1:36225_solr) 
[n:127.0.0.1:36225_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (0)
   [junit4]   2> 6816 INFO  (jetty-closer-22-thread-1) [    ] o.a.s.c.Overseer 
Overseer (id=72102367002886147-127.0.0.1:36225_solr-n_0000000000) closing
   [junit4]   2> 6816 INFO  
(OverseerStateUpdate-72102367002886147-127.0.0.1:36225_solr-n_0000000000) 
[n:127.0.0.1:36225_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:36225_solr
   [junit4]   2> 6817 WARN  
(OverseerAutoScalingTriggerThread-72102367002886147-127.0.0.1:36225_solr-n_0000000000)
 [n:127.0.0.1:36225_solr    ] o.a.s.c.a.OverseerTriggerThread 
OverseerTriggerThread woken up but we are closed, exiting.
   [junit4]   2> 6817 DEBUG (jetty-closer-22-thread-1) [    ] 
o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
   [junit4]   2> 6819 INFO  (jetty-closer-22-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@47cf4c57{/solr,null,UNAVAILABLE}
   [junit4]   2> 6819 INFO  (jetty-closer-22-thread-1) [    ] o.e.j.s.session 
Stopped scavenging
   [junit4]   2> 6820 ERROR 
(SUITE-ScheduledMaintenanceTriggerTest-seed#[25F4CC897CAC5672]-worker) [    ] 
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper 
server won't take any action on ERROR or SHUTDOWN server state changes
   [junit4]   2> 6820 INFO  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[25F4CC897CAC5672]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:36797 36797
   [junit4]   2> 6864 INFO  (Thread-11) [    ] o.a.s.c.ZkTestServer connecting 
to 127.0.0.1:36797 36797
   [junit4]   2> 6865 WARN  (Thread-11) [    ] o.a.s.c.ZkTestServer Watch limit 
violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        2       /solr/aliases.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        2       /solr/clusterstate.json
   [junit4]   2>        2       /solr/clusterprops.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        2       /solr/live_nodes
   [junit4]   2>        2       /solr/collections
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest_25F4CC897CAC5672-001
   [junit4]   2> Mar 08, 2018 9:46:15 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 3 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, 
docValues:{}, maxPointsInLeafNode=730, maxMBSortInHeap=5.178801231679538, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@5d460053),
 locale=mr-IN, timezone=America/Recife
   [junit4]   2> NOTE: Linux 4.13.0-36-generic amd64/Oracle Corporation 9.0.4 
(64-bit)/cpus=8,threads=1,free=345901400,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: 
[ScheduledMaintenanceTriggerTest, ScheduledMaintenanceTriggerTest]
   [junit4] Completed [5/5 (2!)] on J1 in 1.95s, 2 tests, 1 failure <<< 
FAILURES!

[...truncated 12 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1561: 
The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1085: 
There were test failures: 5 suites, 10 tests, 2 failures [seed: 
25F4CC897CAC5672]

Total time: 11 seconds

[repro] Setting last failure code to 256

[repro] Failures:
[repro]   2/5 failed: 
org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest
[repro] Exiting with code 256
+ mv lucene/build lucene/build.repro
+ mv solr/build solr/build.repro
+ mv lucene/build.orig lucene/build
+ mv solr/build.orig solr/build
Archiving artifacts
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all 
warnings.
<Git Blamer> GIT_COMMIT=ab4cd42903925f3edc3d06c41a4726e78a6b08ca, 
workspace=/var/lib/jenkins/workspace/Lucene-Solr-master-Linux
[WARNINGS] Computing warning deltas based on reference build #21596
Recording test results
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to