[JENKINS] Lucene-Solr-Tests-master - Build # 2407 - Unstable

[Apache Jenkins Server]

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

1 tests failed.
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([70D2FE4BA89C94F3:6DFE3E39C9DFB3F8]: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 sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 14039 lines...]
   [junit4] Suite: 
org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest
   [junit4]   2> Creating dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest_70D2FE4BA89C94F3-001/init-core-data-001
   [junit4]   2> 1731831 WARN  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[70D2FE4BA89C94F3]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
   [junit4]   2> 1731831 INFO  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[70D2FE4BA89C94F3]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 1731833 INFO  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[70D2FE4BA89C94F3]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 1731834 INFO  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[70D2FE4BA89C94F3]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 1731834 INFO  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[70D2FE4BA89C94F3]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest_70D2FE4BA89C94F3-001/tempDir-001
   [junit4]   2> 1731834 INFO  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[70D2FE4BA89C94F3]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1731834 INFO  (Thread-3369) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1731834 INFO  (Thread-3369) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1731836 ERROR (Thread-3369) [    ] 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> 1731935 INFO  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[70D2FE4BA89C94F3]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:36539
   [junit4]   2> 1731937 INFO  (zkConnectionManagerCallback-6662-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1731940 INFO  (jetty-launcher-6659-thread-1) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-21T18:27:37-03:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 1731941 INFO  (jetty-launcher-6659-thread-1) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1731941 INFO  (jetty-launcher-6659-thread-1) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1731941 INFO  (jetty-launcher-6659-thread-1) [    ] 
o.e.j.s.session Scavenging every 600000ms
   [junit4]   2> 1731941 INFO  (jetty-launcher-6659-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@19a5b2c2{/solr,null,AVAILABLE}
   [junit4]   2> 1731943 INFO  (jetty-launcher-6659-thread-1) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@17faa309{SSL,[ssl, 
http/1.1]}{127.0.0.1:33291}
   [junit4]   2> 1731943 INFO  (jetty-launcher-6659-thread-1) [    ] 
o.e.j.s.Server Started @1734283ms
   [junit4]   2> 1731943 INFO  (jetty-launcher-6659-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=33291}
   [junit4]   2> 1731944 ERROR (jetty-launcher-6659-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1731944 INFO  (jetty-launcher-6659-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1731944 INFO  (jetty-launcher-6659-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1731944 INFO  (jetty-launcher-6659-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1731944 INFO  (jetty-launcher-6659-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-03-08T22:29:47.408Z
   [junit4]   2> 1731945 INFO  (zkConnectionManagerCallback-6664-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1731945 INFO  (jetty-launcher-6659-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1731953 INFO  (jetty-launcher-6659-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36539/solr
   [junit4]   2> 1731954 INFO  (zkConnectionManagerCallback-6668-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1731955 INFO  
(zkConnectionManagerCallback-6670-thread-1-processing-n:127.0.0.1:33291_solr) 
[n:127.0.0.1:33291_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1732016 INFO  (jetty-launcher-6659-thread-1) 
[n:127.0.0.1:33291_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1732016 INFO  (jetty-launcher-6659-thread-1) 
[n:127.0.0.1:33291_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:33291_solr
   [junit4]   2> 1732017 INFO  (jetty-launcher-6659-thread-1) 
[n:127.0.0.1:33291_solr    ] o.a.s.c.Overseer Overseer 
(id=72246703948562435-127.0.0.1:33291_solr-n_0000000000) starting
   [junit4]   2> 1732023 INFO  (jetty-launcher-6659-thread-1) 
[n:127.0.0.1:33291_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:33291_solr
   [junit4]   2> 1732023 DEBUG 
(OverseerAutoScalingTriggerThread-72246703948562435-127.0.0.1:33291_solr-n_0000000000)
 [n:127.0.0.1:33291_solr    ] o.a.s.c.a.OverseerTriggerThread Adding 
.auto_add_replicas and .scheduled_maintenance triggers
   [junit4]   2> 1732031 DEBUG 
(OverseerAutoScalingTriggerThread-72246703948562435-127.0.0.1:33291_solr-n_0000000000)
 [n:127.0.0.1:33291_solr    ] o.a.s.c.a.OverseerTriggerThread Refreshing 
/autoscaling.json with znode version 1
   [junit4]   2> 1732031 INFO  
(zkCallback-6669-thread-1-processing-n:127.0.0.1:33291_solr) 
[n:127.0.0.1:33291_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1732031 DEBUG 
(OverseerAutoScalingTriggerThread-72246703948562435-127.0.0.1:33291_solr-n_0000000000)
 [n:127.0.0.1:33291_solr    ] o.a.s.c.a.NodeLostTrigger Initial livenodes: 
[127.0.0.1:33291_solr]
   [junit4]   2> 1732032 DEBUG 
(OverseerAutoScalingTriggerThread-72246703948562435-127.0.0.1:33291_solr-n_0000000000)
 [n:127.0.0.1:33291_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 1, lastZnodeVersion -1
   [junit4]   2> 1732032 DEBUG 
(OverseerAutoScalingTriggerThread-72246703948562435-127.0.0.1:33291_solr-n_0000000000)
 [n:127.0.0.1:33291_solr    ] o.a.s.c.a.OverseerTriggerThread Processed trigger 
updates upto znodeVersion 1
   [junit4]   2> 1732041 DEBUG 
(OverseerAutoScalingTriggerThread-72246703948562435-127.0.0.1:33291_solr-n_0000000000)
 [n:127.0.0.1:33291_solr    ] o.a.s.c.a.OverseerTriggerThread -- clean old 
nodeAdded markers
   [junit4]   2> 1732042 DEBUG (ScheduledTrigger-6662-thread-1) 
[n:127.0.0.1:33291_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1732042 DEBUG 
(OverseerAutoScalingTriggerThread-72246703948562435-127.0.0.1:33291_solr-n_0000000000)
 [n:127.0.0.1:33291_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 1, lastZnodeVersion 1
   [junit4]   2> 1732089 INFO  (jetty-launcher-6659-thread-1) 
[n:127.0.0.1:33291_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_33291.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@351adf52
   [junit4]   2> 1732097 INFO  (jetty-launcher-6659-thread-1) 
[n:127.0.0.1:33291_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_33291.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@351adf52
   [junit4]   2> 1732097 INFO  (jetty-launcher-6659-thread-1) 
[n:127.0.0.1:33291_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_33291.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@351adf52
   [junit4]   2> 1732098 INFO  (jetty-launcher-6659-thread-1) 
[n:127.0.0.1:33291_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest_70D2FE4BA89C94F3-001/tempDir-001/node1/.
   [junit4]   2> 1732114 INFO  (zkConnectionManagerCallback-6674-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1732117 INFO  (zkConnectionManagerCallback-6678-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1732118 INFO  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[70D2FE4BA89C94F3]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1732118 INFO  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[70D2FE4BA89C94F3]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:36539/solr ready
   [junit4]   2> 1732122 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and 
.scheduled_maintenance triggers
   [junit4]   2> 1732122 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode 
version 0
   [junit4]   2> 1732123 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10133_solr]
   [junit4]   2> 1732123 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion -1
   [junit4]   2> 1732123 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 0
   [junit4]   2> 1732125 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1732129 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion 0
   [junit4]   2> 1732130 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732137 INFO  
(TEST-ScheduledMaintenanceTriggerTest.testInactiveShardCleanup-seed#[70D2FE4BA89C94F3])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testInactiveShardCleanup
   [junit4]   2> 1732150 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732171 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732191 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732211 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732231 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732252 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732272 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732281 DEBUG (simCloudManagerPool-6668-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:10133_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> 1732281 DEBUG (simCloudManagerPool-6668-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:10133_solr",
   [junit4]   2>     "base_url":"http://127.0.0.1:10133/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> 1732281 DEBUG (simCloudManagerPool-6668-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:10133_solr",
   [junit4]   2>     "base_url":"http://127.0.0.1:10133/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> 1732283 DEBUG (simCloudManagerPool-6668-thread-7) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1732283 DEBUG (simCloudManagerPool-6668-thread-7) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
1
   [junit4]   2> 1732283 DEBUG (simCloudManagerPool-6668-thread-7) [    ] 
o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10133_solr]
   [junit4]   2> 1732283 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
   [junit4]   2> 1732284 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1732284 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
   [junit4]   2> 1732284 DEBUG (simCloudManagerPool-6668-thread-8) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1732284 DEBUG (simCloudManagerPool-6668-thread-8) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
2
   [junit4]   2> 1732285 DEBUG (simCloudManagerPool-6668-thread-8) [    ] 
o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10133_solr]
   [junit4]   2> 1732285 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2
   [junit4]   2> 1732285 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1732285 DEBUG (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2
   [junit4]   2> 1732285 WARN  (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:29:49.586Z. Now: 2018-03-09T20:46:22.286Z
   [junit4]   2> 1732286 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bc1592T3dh4wqyj2ombtlmxpkxr3mjb",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548189586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628382286},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732292 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732307 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:29:51.586Z. Now: 2018-03-09T20:46:23.395Z
   [junit4]   2> 1732307 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bc1d62T3dh4wqyj2ombtlmxpkxr3mjd",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548191586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628383395},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732312 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732328 WARN  (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:29:53.586Z. Now: 2018-03-09T20:46:24.444Z
   [junit4]   2> 1732328 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bc2532T3dh4wqyj2ombtlmxpkxr3mjf",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548193586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628384444},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732332 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732349 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:29:55.586Z. Now: 2018-03-09T20:46:25.480Z
   [junit4]   2> 1732349 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bc2d02T3dh4wqyj2ombtlmxpkxr3mjh",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548195586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628385480},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732353 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732370 WARN  (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:29:57.586Z. Now: 2018-03-09T20:46:26.514Z
   [junit4]   2> 1732370 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bc34d2T3dh4wqyj2ombtlmxpkxr3mjj",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548197586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628386514},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732373 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732390 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:29:59.586Z. Now: 2018-03-09T20:46:27.549Z
   [junit4]   2> 1732390 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bc3ca2T3dh4wqyj2ombtlmxpkxr3mjl",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548199586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628387549},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732393 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732411 WARN  (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:01.586Z. Now: 2018-03-09T20:46:28.585Z
   [junit4]   2> 1732411 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bc4472T3dh4wqyj2ombtlmxpkxr3mjn",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548201586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628388585},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732413 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732432 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:03.586Z. Now: 2018-03-09T20:46:29.625Z
   [junit4]   2> 1732432 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bc4c42T3dh4wqyj2ombtlmxpkxr3mjp",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548203586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628389625},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732434 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732453 WARN  (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:05.586Z. Now: 2018-03-09T20:46:30.666Z
   [junit4]   2> 1732453 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bc5412T3dh4wqyj2ombtlmxpkxr3mjr",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548205586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628390666},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732454 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732473 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:07.586Z. Now: 2018-03-09T20:46:31.706Z
   [junit4]   2> 1732474 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bc5be2T3dh4wqyj2ombtlmxpkxr3mjt",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548207586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628391706},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732474 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732494 WARN  (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:09.586Z. Now: 2018-03-09T20:46:32.743Z
   [junit4]   2> 1732494 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732494 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bc63b2T3dh4wqyj2ombtlmxpkxr3mjv",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548209586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628392743},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732514 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732515 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:11.586Z. Now: 2018-03-09T20:46:33.779Z
   [junit4]   2> 1732515 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bc6b82T3dh4wqyj2ombtlmxpkxr3mjx",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548211586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628393779},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732535 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732541 WARN  (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:13.586Z. Now: 2018-03-09T20:46:35.074Z
   [junit4]   2> 1732541 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bc7352T3dh4wqyj2ombtlmxpkxr3mjz",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548213586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628395074},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732555 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732562 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:15.586Z. Now: 2018-03-09T20:46:36.115Z
   [junit4]   2> 1732562 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bc7b22T3dh4wqyj2ombtlmxpkxr3mk1",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548215586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628396115},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732575 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732582 WARN  (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:17.586Z. Now: 2018-03-09T20:46:37.153Z
   [junit4]   2> 1732583 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bc82f2T3dh4wqyj2ombtlmxpkxr3mk3",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548217586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628397153},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732595 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732603 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:19.586Z. Now: 2018-03-09T20:46:38.201Z
   [junit4]   2> 1732603 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bc8ac2T3dh4wqyj2ombtlmxpkxr3mk5",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548219586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628398201},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732616 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732624 WARN  (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:21.586Z. Now: 2018-03-09T20:46:39.241Z
   [junit4]   2> 1732624 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bc9292T3dh4wqyj2ombtlmxpkxr3mk7",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548221586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628399241},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732636 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732645 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:23.586Z. Now: 2018-03-09T20:46:40.283Z
   [junit4]   2> 1732645 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bc9a62T3dh4wqyj2ombtlmxpkxr3mk9",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548223586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628400283},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732656 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732666 WARN  (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:25.586Z. Now: 2018-03-09T20:46:41.327Z
   [junit4]   2> 1732666 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bca232T3dh4wqyj2ombtlmxpkxr3mkb",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548225586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628401327},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732676 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732687 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:27.586Z. Now: 2018-03-09T20:46:42.372Z
   [junit4]   2> 1732687 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bcaa02T3dh4wqyj2ombtlmxpkxr3mkd",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548227586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628402372},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732697 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732708 WARN  (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:29.586Z. Now: 2018-03-09T20:46:43.415Z
   [junit4]   2> 1732708 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bcb1d2T3dh4wqyj2ombtlmxpkxr3mkf",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548229586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628403415},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732717 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732728 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:31.586Z. Now: 2018-03-09T20:46:44.462Z
   [junit4]   2> 1732729 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bcb9a2T3dh4wqyj2ombtlmxpkxr3mkh",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548231586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628404462},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732737 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732749 WARN  (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:33.586Z. Now: 2018-03-09T20:46:45.505Z
   [junit4]   2> 1732749 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bcc172T3dh4wqyj2ombtlmxpkxr3mkj",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548233586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628405505},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732757 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732770 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:35.586Z. Now: 2018-03-09T20:46:46.542Z
   [junit4]   2> 1732770 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bcc942T3dh4wqyj2ombtlmxpkxr3mkl",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548235586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628406542},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732778 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732791 WARN  (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:37.586Z. Now: 2018-03-09T20:46:47.591Z
   [junit4]   2> 1732791 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bcd112T3dh4wqyj2ombtlmxpkxr3mkn",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548237586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628407591},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732798 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732812 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:39.586Z. Now: 2018-03-09T20:46:48.630Z
   [junit4]   2> 1732812 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bcd8e2T3dh4wqyj2ombtlmxpkxr3mkp",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548239586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628408630},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732818 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732833 WARN  (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:41.586Z. Now: 2018-03-09T20:46:49.670Z
   [junit4]   2> 1732833 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bce0b2T3dh4wqyj2ombtlmxpkxr3mkr",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548241586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628409670},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732838 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732854 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:43.586Z. Now: 2018-03-09T20:46:50.710Z
   [junit4]   2> 1732854 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bce882T3dh4wqyj2ombtlmxpkxr3mkt",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548243586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628410710},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732859 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732874 WARN  (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:45.586Z. Now: 2018-03-09T20:46:51.755Z
   [junit4]   2> 1732875 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bcf052T3dh4wqyj2ombtlmxpkxr3mkv",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548245586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628411755},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732879 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732895 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:47.586Z. Now: 2018-03-09T20:46:52.798Z
   [junit4]   2> 1732895 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bcf822T3dh4wqyj2ombtlmxpkxr3mkx",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548247586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628412798},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732899 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732916 WARN  (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:49.586Z. Now: 2018-03-09T20:46:53.837Z
   [junit4]   2> 1732916 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bcfff2T3dh4wqyj2ombtlmxpkxr3mkz",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548249586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628413837},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732919 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732937 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:51.586Z. Now: 2018-03-09T20:46:54.880Z
   [junit4]   2> 1732937 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bd07c2T3dh4wqyj2ombtlmxpkxr3ml1",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548251586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628414880},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732939 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732958 WARN  (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:53.586Z. Now: 2018-03-09T20:46:55.928Z
   [junit4]   2> 1732958 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bd0f92T3dh4wqyj2ombtlmxpkxr3ml3",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548253586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628415928},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732960 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1732979 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:55.586Z. Now: 2018-03-09T20:46:56.978Z
   [junit4]   2> 1732979 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bd1762T3dh4wqyj2ombtlmxpkxr3ml5",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548255586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628416978},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1732980 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733000 WARN  (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:57.586Z. Now: 2018-03-09T20:46:58.024Z
   [junit4]   2> 1733000 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bd1f32T3dh4wqyj2ombtlmxpkxr3ml7",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548257586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628418024},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733000 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733020 WARN  (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:30:59.586Z. Now: 2018-03-09T20:46:59.060Z
   [junit4]   2> 1733020 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733021 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bd2702T3dh4wqyj2ombtlmxpkxr3ml9",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548259586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628419060},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733041 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733042 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:01.586Z. Now: 2018-03-09T20:47:00.117Z
   [junit4]   2> 1733042 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bd2ed2T3dh4wqyj2ombtlmxpkxr3mlb",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548261586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628420117},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733043 DEBUG (ScheduledTrigger-6662-thread-3) 
[n:127.0.0.1:33291_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1733061 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733063 WARN  (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:03.586Z. Now: 2018-03-09T20:47:01.208Z
   [junit4]   2> 1733064 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bd36a2T3dh4wqyj2ombtlmxpkxr3mld",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548263586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628421208},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733081 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733084 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:05.586Z. Now: 2018-03-09T20:47:02.247Z
   [junit4]   2> 1733084 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bd3e72T3dh4wqyj2ombtlmxpkxr3mlf",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548265586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628422247},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733102 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733105 WARN  (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:07.586Z. Now: 2018-03-09T20:47:03.290Z
   [junit4]   2> 1733105 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bd4642T3dh4wqyj2ombtlmxpkxr3mlh",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548267586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628423290},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733122 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733126 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:09.586Z. Now: 2018-03-09T20:47:04.333Z
   [junit4]   2> 1733126 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bd4e12T3dh4wqyj2ombtlmxpkxr3mlj",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548269586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628424333},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733142 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733147 WARN  (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:11.586Z. Now: 2018-03-09T20:47:05.374Z
   [junit4]   2> 1733147 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bd55e2T3dh4wqyj2ombtlmxpkxr3mll",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548271586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628425374},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733162 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733167 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:13.586Z. Now: 2018-03-09T20:47:06.407Z
   [junit4]   2> 1733168 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bd5db2T3dh4wqyj2ombtlmxpkxr3mln",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548273586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628426407},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733183 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733188 WARN  (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:15.586Z. Now: 2018-03-09T20:47:07.439Z
   [junit4]   2> 1733188 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bd6582T3dh4wqyj2ombtlmxpkxr3mlp",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548275586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628427439},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733203 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733209 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:17.586Z. Now: 2018-03-09T20:47:08.476Z
   [junit4]   2> 1733209 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bd6d52T3dh4wqyj2ombtlmxpkxr3mlr",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548277586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628428476},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733223 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733229 WARN  (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:19.586Z. Now: 2018-03-09T20:47:09.510Z
   [junit4]   2> 1733230 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bd7522T3dh4wqyj2ombtlmxpkxr3mlt",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548279586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628429510},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733243 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733250 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:21.586Z. Now: 2018-03-09T20:47:10.544Z
   [junit4]   2> 1733250 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bd7cf2T3dh4wqyj2ombtlmxpkxr3mlv",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548281586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628430544},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733264 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733271 WARN  (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:23.586Z. Now: 2018-03-09T20:47:11.590Z
   [junit4]   2> 1733271 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bd84c2T3dh4wqyj2ombtlmxpkxr3mlx",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548283586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628431590},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733284 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733292 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:25.586Z. Now: 2018-03-09T20:47:12.631Z
   [junit4]   2> 1733292 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bd8c92T3dh4wqyj2ombtlmxpkxr3mlz",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548285586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628432631},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733304 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733313 WARN  (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:27.586Z. Now: 2018-03-09T20:47:13.674Z
   [junit4]   2> 1733313 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bd9462T3dh4wqyj2ombtlmxpkxr3mm1",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548287586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628433674},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733324 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733334 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:29.586Z. Now: 2018-03-09T20:47:14.714Z
   [junit4]   2> 1733334 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bd9c32T3dh4wqyj2ombtlmxpkxr3mm3",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548289586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628434714},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733345 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733354 WARN  (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:31.586Z. Now: 2018-03-09T20:47:15.758Z
   [junit4]   2> 1733355 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bda402T3dh4wqyj2ombtlmxpkxr3mm5",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548291586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628435758},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733365 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733375 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:33.586Z. Now: 2018-03-09T20:47:16.810Z
   [junit4]   2> 1733376 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bdabd2T3dh4wqyj2ombtlmxpkxr3mm7",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548293586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628436810},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733385 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733396 WARN  (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:35.586Z. Now: 2018-03-09T20:47:17.855Z
   [junit4]   2> 1733397 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bdb3a2T3dh4wqyj2ombtlmxpkxr3mm9",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548295586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628437855},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733405 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733417 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:37.586Z. Now: 2018-03-09T20:47:18.896Z
   [junit4]   2> 1733417 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bdbb72T3dh4wqyj2ombtlmxpkxr3mmb",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548297586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628438896},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733426 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733439 WARN  (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:39.586Z. Now: 2018-03-09T20:47:19.990Z
   [junit4]   2> 1733439 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bdc342T3dh4wqyj2ombtlmxpkxr3mmd",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548299586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628439990},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733446 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733460 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:41.586Z. Now: 2018-03-09T20:47:21.030Z
   [junit4]   2> 1733460 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bdcb12T3dh4wqyj2ombtlmxpkxr3mmf",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548301586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628441030},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733466 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733481 WARN  (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:43.586Z. Now: 2018-03-09T20:47:22.073Z
   [junit4]   2> 1733481 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bdd2e2T3dh4wqyj2ombtlmxpkxr3mmh",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548303586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628442073},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733486 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733501 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:45.586Z. Now: 2018-03-09T20:47:23.109Z
   [junit4]   2> 1733502 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bddab2T3dh4wqyj2ombtlmxpkxr3mmj",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548305586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628443109},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733507 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733522 WARN  (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:47.586Z. Now: 2018-03-09T20:47:24.152Z
   [junit4]   2> 1733522 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bde282T3dh4wqyj2ombtlmxpkxr3mml",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548307586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628444152},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733527 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733543 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:49.586Z. Now: 2018-03-09T20:47:25.189Z
   [junit4]   2> 1733543 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bdea52T3dh4wqyj2ombtlmxpkxr3mmn",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548309586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628445189},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733547 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733564 WARN  (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:51.586Z. Now: 2018-03-09T20:47:26.224Z
   [junit4]   2> 1733564 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bdf222T3dh4wqyj2ombtlmxpkxr3mmp",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548311586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628446224},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733567 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733585 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:53.586Z. Now: 2018-03-09T20:47:27.265Z
   [junit4]   2> 1733585 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207bdf9f2T3dh4wqyj2ombtlmxpkxr3mmr",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548313586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628447265},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733588 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733605 WARN  (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:55.586Z. Now: 2018-03-09T20:47:28.298Z
   [junit4]   2> 1733605 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207be01c2T3dh4wqyj2ombtlmxpkxr3mmt",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548315586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628448298},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733608 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733626 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:57.586Z. Now: 2018-03-09T20:47:29.334Z
   [junit4]   2> 1733626 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207be0992T3dh4wqyj2ombtlmxpkxr3mmv",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548317586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628449334},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733628 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733647 WARN  (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:31:59.586Z. Now: 2018-03-09T20:47:30.373Z
   [junit4]   2> 1733647 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207be1162T3dh4wqyj2ombtlmxpkxr3mmx",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548319586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628450373},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733648 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733667 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:32:01.586Z. Now: 2018-03-09T20:47:31.406Z
   [junit4]   2> 1733667 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207be1932T3dh4wqyj2ombtlmxpkxr3mmz",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548321586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628451406},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733669 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733688 WARN  (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:32:03.586Z. Now: 2018-03-09T20:47:32.439Z
   [junit4]   2> 1733688 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207be2102T3dh4wqyj2ombtlmxpkxr3mn1",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548323586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628452439},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733689 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733709 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:32:05.586Z. Now: 2018-03-09T20:47:33.474Z
   [junit4]   2> 1733709 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207be28d2T3dh4wqyj2ombtlmxpkxr3mn3",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548325586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628453474},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733709 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733729 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733731 WARN  (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:32:07.586Z. Now: 2018-03-09T20:47:34.593Z
   [junit4]   2> 1733731 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207be30a2T3dh4wqyj2ombtlmxpkxr3mn5",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548327586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628454593},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733750 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733752 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:32:09.586Z. Now: 2018-03-09T20:47:35.637Z
   [junit4]   2> 1733752 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207be3872T3dh4wqyj2ombtlmxpkxr3mn7",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548329586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628455637},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733770 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733773 WARN  (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:32:11.586Z. Now: 2018-03-09T20:47:36.675Z
   [junit4]   2> 1733773 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207be4042T3dh4wqyj2ombtlmxpkxr3mn9",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548331586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628456675},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733790 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733793 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:32:13.586Z. Now: 2018-03-09T20:47:37.709Z
   [junit4]   2> 1733794 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207be4812T3dh4wqyj2ombtlmxpkxr3mnb",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548333586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628457709},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733810 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733814 WARN  (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:32:15.586Z. Now: 2018-03-09T20:47:38.750Z
   [junit4]   2> 1733815 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207be4fe2T3dh4wqyj2ombtlmxpkxr3mnd",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548335586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628458750},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733831 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733835 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:32:17.586Z. Now: 2018-03-09T20:47:39.796Z
   [junit4]   2> 1733835 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207be57b2T3dh4wqyj2ombtlmxpkxr3mnf",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548337586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628459796},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733851 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733856 WARN  (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:32:19.586Z. Now: 2018-03-09T20:47:40.829Z
   [junit4]   2> 1733856 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207be5f82T3dh4wqyj2ombtlmxpkxr3mnh",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548339586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628460829},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733871 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733876 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:32:21.586Z. Now: 2018-03-09T20:47:41.861Z
   [junit4]   2> 1733877 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207be6752T3dh4wqyj2ombtlmxpkxr3mnj",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548341586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628461861},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733891 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733897 WARN  (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:32:23.586Z. Now: 2018-03-09T20:47:42.898Z
   [junit4]   2> 1733897 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207be6f22T3dh4wqyj2ombtlmxpkxr3mnl",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548343586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628462898},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733912 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733918 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:32:25.586Z. Now: 2018-03-09T20:47:43.944Z
   [junit4]   2> 1733918 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207be76f2T3dh4wqyj2ombtlmxpkxr3mnn",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548345586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628463944},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733932 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733939 WARN  (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:32:27.586Z. Now: 2018-03-09T20:47:44.990Z
   [junit4]   2> 1733939 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207be7ec2T3dh4wqyj2ombtlmxpkxr3mnp",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548347586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628464990},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733952 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733960 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:32:29.586Z. Now: 2018-03-09T20:47:46.023Z
   [junit4]   2> 1733960 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207be8692T3dh4wqyj2ombtlmxpkxr3mnr",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548349586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628466023},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733972 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1733980 WARN  (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:32:31.586Z. Now: 2018-03-09T20:47:47.058Z
   [junit4]   2> 1733981 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207be8e62T3dh4wqyj2ombtlmxpkxr3mnt",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548351586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628467058},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1733993 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1734001 WARN  (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:32:33.586Z. Now: 2018-03-09T20:47:48.092Z
   [junit4]   2> 1734001 DEBUG (ScheduledTrigger-6669-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207be9632T3dh4wqyj2ombtlmxpkxr3mnv",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548353586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628468092},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1734013 DEBUG (ScheduledTrigger-6669-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 1734022 WARN  (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-08T22:32:35.586Z. Now: 2018-03-09T20:47:49.126Z
   [junit4]   2> 1734022 DEBUG (ScheduledTrigger-6669-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"16207be9e02T3dh4wqyj2ombtlmxpkxr3mnx",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520548355586,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520628469126},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1734033 DEBUG (ScheduledTrigger-6669-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live

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

":[
   [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> 1792387 INFO  
(TEST-ScheduledMaintenanceTriggerTest.testTriggerDefaults-seed#[70D2FE4BA89C94F3])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testTriggerDefaults
   [junit4]   2> 1792387 WARN  (Simulated OverseerAutoScalingTriggerThread) [   
 ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are 
closed, exiting.
   [junit4]   2> 1792388 DEBUG 
(SUITE-ScheduledMaintenanceTriggerTest-seed#[70D2FE4BA89C94F3]-worker) [    ] 
o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
   [junit4]   2> 1792390 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 
0x100abfe950c0005, likely client has closed socket
   [junit4]   2> 1792404 INFO  (jetty-closer-6660-thread-1) [    ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@17faa309{SSL,[ssl, 
http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1792404 INFO  (jetty-closer-6660-thread-1) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=988152375
   [junit4]   2> 1792404 INFO  (jetty-closer-6660-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 1792405 INFO  (jetty-closer-6660-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@37e9cdab: rootName = 
solr_33291, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@531abd9c
   [junit4]   2> 1792409 INFO  (jetty-closer-6660-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 1792409 INFO  (jetty-closer-6660-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@7a15b997: rootName = 
solr_33291, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@16797d46
   [junit4]   2> 1792412 INFO  (jetty-closer-6660-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 1792412 INFO  (jetty-closer-6660-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@301d91cd: rootName = 
solr_33291, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@289104ab
   [junit4]   2> 1792414 INFO  (jetty-closer-6660-thread-1) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:33291_solr
   [junit4]   2> 1792414 INFO  (jetty-closer-6660-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 1792414 INFO  (jetty-closer-6660-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 1792415 INFO  (jetty-closer-6660-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=72246703948562435-127.0.0.1:33291_solr-n_0000000000) closing
   [junit4]   2> 1792415 INFO  
(zkCallback-6669-thread-2-processing-n:127.0.0.1:33291_solr) 
[n:127.0.0.1:33291_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (0)
   [junit4]   2> 1792415 INFO  
(OverseerStateUpdate-72246703948562435-127.0.0.1:33291_solr-n_0000000000) 
[n:127.0.0.1:33291_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:33291_solr
   [junit4]   2> 1792415 WARN  
(OverseerAutoScalingTriggerThread-72246703948562435-127.0.0.1:33291_solr-n_0000000000)
 [n:127.0.0.1:33291_solr    ] o.a.s.c.a.OverseerTriggerThread 
OverseerTriggerThread woken up but we are closed, exiting.
   [junit4]   2> 1792415 DEBUG (jetty-closer-6660-thread-1) [    ] 
o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
   [junit4]   2> 1792416 INFO  (jetty-closer-6660-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@19a5b2c2{/solr,null,UNAVAILABLE}
   [junit4]   2> 1792416 INFO  (jetty-closer-6660-thread-1) [    ] 
o.e.j.s.session Stopped scavenging
   [junit4]   2> 1792417 ERROR 
(SUITE-ScheduledMaintenanceTriggerTest-seed#[70D2FE4BA89C94F3]-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> 1792417 INFO  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[70D2FE4BA89C94F3]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:36539 36539
   [junit4]   2> 1792453 INFO  (Thread-3369) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:36539 36539
   [junit4]   2> 1792454 WARN  (Thread-3369) [    ] 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/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest_70D2FE4BA89C94F3-001
   [junit4]   2> Mar 08, 2018 10:30:47 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=420, maxMBSortInHeap=6.896837313499306, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@15461c16),
 locale=es-ES, timezone=Europe/Andorra
   [junit4]   2> NOTE: Linux 4.4.0-112-generic amd64/Oracle Corporation 
1.8.0_152 (64-bit)/cpus=4,threads=1,free=193363632,total=522715136
   [junit4]   2> NOTE: All tests run in this JVM: [SyncSliceTest, 
TestManagedSchemaThreadSafety, TestTrie, TestCharFilters, 
TestBinaryResponseWriter, TestUseDocValuesAsStored2, TestScoreJoinQPNoScore, 
BaseCdcrDistributedZkTest, SolrMetricReporterTest, CachingDirectoryFactoryTest, 
TestConfigSetImmutable, BlockJoinFacetDistribTest, LoggingHandlerTest, 
TestSchemalessBufferedUpdates, TestLargeCluster, 
ManagedSchemaRoundRobinCloudTest, PathHierarchyTokenizerFactoryTest, 
TermsComponentTest, TimeRoutedAliasUpdateProcessorTest, 
TestLocalFSCloudBackupRestore, CollectionReloadTest, TestReplicationHandler, 
ResponseHeaderTest, TestSolrConfigHandlerCloud, SolrCoreTest, 
ResourceLoaderTest, TestFieldCacheVsDocValues, DistributedVersionInfoTest, 
TestCollectionAPI, DistributedFacetPivotLongTailTest, 
TestBM25SimilarityFactory, TestSolrCloudWithKerberosAlt, 
TestAddFieldRealTimeGet, MetricsConfigTest, BlockDirectoryTest, 
MigrateRouteKeyTest, TestSolrIndexConfig, PrimUtilsTest, TestSearcherReuse, 
TestFieldCacheReopen, ShardRoutingCustomTest, TestNumericTokenStream, 
DeleteShardTest, SolrSlf4jReporterTest, StressHdfsTest, TestFastLRUCache, 
TestStressRecovery, SOLR749Test, CSVRequestHandlerTest, 
BigEndianAscendingWordDeserializerTest, CloudMLTQParserTest, 
TestFilteredDocIdSet, TestLRUCache, TestDynamicFieldResource, 
DistributedMLTComponentTest, RequiredFieldsTest, CoreAdminCreateDiscoverTest, 
SimplePostToolTest, BadComponentTest, MergeStrategyTest, TestXIncludeConfig, 
TestJsonFacetRefinement, TestHalfAndHalfDocValues, TestSolr4Spatial2, 
RulesTest, LIRRollingUpdatesTest, SuggestComponentContextFilterQueryTest, 
TestSystemIdResolver, SolrXmlInZkTest, TestPolicyCloud, ScriptEngineTest, 
OverseerTest, QueryResultKeyTest, DistribDocExpirationUpdateProcessorTest, 
TestTestInjection, CollectionsAPIDistributedZkTest, DataDrivenBlockJoinTest, 
TestSolr4Spatial, BasicFunctionalityTest, DOMUtilTest, 
IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestStandardQParsers, 
HighlighterTest, TestRetrieveFieldsOptimizer, PrimitiveFieldTypeTest, 
DirectoryFactoryTest, CollectionPropsTest, TestCorePropertiesReload, 
TestRecovery, TestInitQParser, TestPerFieldSimilarity, 
TestSizeLimitedDistributedMap, RegexBytesRefFilterTest, 
TestStressInPlaceUpdates, ReplaceNodeTest, TestSha256AuthenticationProvider, 
ReplicaListTransformerTest, SolrInfoBeanTest, AtomicUpdatesTest, 
AsyncCallRequestStatusResponseTest, TestSubQueryTransformer, 
HdfsCollectionsAPIDistributedZkTest, LeaderFailureAfterFreshStartTest, 
SolrGraphiteReporterTest, TestMiniSolrCloudClusterSSL, TestReload, 
TestFieldTypeCollectionResource, DistributedIntervalFacetingTest, 
TestReversedWildcardFilterFactory, ExplicitHLLTest, TestSSLRandomization, 
TestManagedSynonymFilterFactory, ChaosMonkeySafeLeaderTest, TestRestoreCore, 
ConcurrentCreateRoutedAliasTest, SliceStateTest, XsltUpdateRequestHandlerTest, 
ZkFailoverTest, NodeLostTriggerTest, SampleTest, SearchRateTriggerTest, 
TestRandomRequestDistribution, BasicAuthIntegrationTest, HdfsLockFactoryTest, 
HdfsRestartWhileUpdatingTest, SuggesterFSTTest, FileUtilsTest, TestMacros, 
RollingRestartTest, TestSolrCloudWithSecureImpersonation, TestStressLiveNodes, 
TestTlogReplica, TestReplicaProperties, AutoAddReplicasIntegrationTest, 
AutoAddReplicasPlanActionTest, AutoScalingHandlerTest, HttpTriggerListenerTest, 
MetricTriggerTest, ScheduledMaintenanceTriggerTest]
   [junit4] Completed [578/782 (1!)] on J1 in 60.89s, 2 tests, 1 failure <<< 
FAILURES!

[...truncated 50179 lines...]

---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org