Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/21627/
Java: 64bit/jdk1.8.0_162 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC

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

Error Message:
should be at least one inactive event

Stack Trace:
java.lang.AssertionError: should be at least one inactive event
        at 
__randomizedtesting.SeedInfo.seed([25C2A8FF59E8133E:38EE688D38AB3435]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at 
org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest.testInactiveShardCleanup(ScheduledMaintenanceTriggerTest.java:218)
        at 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 12936 lines...]
   [junit4] Suite: 
org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest_25C2A8FF59E8133E-001/init-core-data-001
   [junit4]   2> 703067 WARN  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[25C2A8FF59E8133E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=5 numCloses=5
   [junit4]   2> 703068 INFO  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[25C2A8FF59E8133E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 703069 INFO  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[25C2A8FF59E8133E]-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> 703069 INFO  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[25C2A8FF59E8133E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 703070 INFO  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[25C2A8FF59E8133E]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest_25C2A8FF59E8133E-001/tempDir-001
   [junit4]   2> 703070 INFO  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[25C2A8FF59E8133E]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 703070 INFO  (Thread-1688) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 703070 INFO  (Thread-1688) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 703073 ERROR (Thread-1688) [    ] 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> 703170 INFO  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[25C2A8FF59E8133E]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:45711
   [junit4]   2> 703172 INFO  (zkConnectionManagerCallback-1721-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 703175 INFO  (jetty-launcher-1718-thread-1) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-21T10:27:37-11:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 703179 INFO  (jetty-launcher-1718-thread-1) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 703179 INFO  (jetty-launcher-1718-thread-1) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 703179 INFO  (jetty-launcher-1718-thread-1) [    ] 
o.e.j.s.session Scavenging every 660000ms
   [junit4]   2> 703179 INFO  (jetty-launcher-1718-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@56f50bbd{/solr,null,AVAILABLE}
   [junit4]   2> 703180 INFO  (jetty-launcher-1718-thread-1) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@4ab5e4ab{SSL,[ssl, 
http/1.1]}{127.0.0.1:42103}
   [junit4]   2> 703180 INFO  (jetty-launcher-1718-thread-1) [    ] 
o.e.j.s.Server Started @705913ms
   [junit4]   2> 703180 INFO  (jetty-launcher-1718-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=42103}
   [junit4]   2> 703180 ERROR (jetty-launcher-1718-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 703180 INFO  (jetty-launcher-1718-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 703180 INFO  (jetty-launcher-1718-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 703180 INFO  (jetty-launcher-1718-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 703181 INFO  (jetty-launcher-1718-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-03-12T19:11:48.824Z
   [junit4]   2> 703182 INFO  (zkConnectionManagerCallback-1723-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 703182 INFO  (jetty-launcher-1718-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 703195 INFO  (jetty-launcher-1718-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:45711/solr
   [junit4]   2> 703196 INFO  (zkConnectionManagerCallback-1727-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 703197 INFO  
(zkConnectionManagerCallback-1729-thread-1-processing-n:127.0.0.1:42103_solr) 
[n:127.0.0.1:42103_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 703233 INFO  (jetty-launcher-1718-thread-1) 
[n:127.0.0.1:42103_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 703234 INFO  (jetty-launcher-1718-thread-1) 
[n:127.0.0.1:42103_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:42103_solr
   [junit4]   2> 703234 INFO  (jetty-launcher-1718-thread-1) 
[n:127.0.0.1:42103_solr    ] o.a.s.c.Overseer Overseer 
(id=72124409025921027-127.0.0.1:42103_solr-n_0000000000) starting
   [junit4]   2> 703237 INFO  
(zkConnectionManagerCallback-1734-thread-1-processing-n:127.0.0.1:42103_solr) 
[n:127.0.0.1:42103_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 703238 INFO  (jetty-launcher-1718-thread-1) 
[n:127.0.0.1:42103_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:45711/solr ready
   [junit4]   2> 703238 INFO  (jetty-launcher-1718-thread-1) 
[n:127.0.0.1:42103_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:42103_solr
   [junit4]   2> 703238 DEBUG 
(OverseerAutoScalingTriggerThread-72124409025921027-127.0.0.1:42103_solr-n_0000000000)
 [n:127.0.0.1:42103_solr    ] o.a.s.c.a.OverseerTriggerThread Adding 
.auto_add_replicas and .scheduled_maintenance triggers
   [junit4]   2> 703247 INFO  
(OverseerStateUpdate-72124409025921027-127.0.0.1:42103_solr-n_0000000000) 
[n:127.0.0.1:42103_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 703247 DEBUG 
(OverseerAutoScalingTriggerThread-72124409025921027-127.0.0.1:42103_solr-n_0000000000)
 [n:127.0.0.1:42103_solr    ] o.a.s.c.a.OverseerTriggerThread Refreshing 
/autoscaling.json with znode version 1
   [junit4]   2> 703247 INFO  
(zkCallback-1733-thread-1-processing-n:127.0.0.1:42103_solr) 
[n:127.0.0.1:42103_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 703247 DEBUG 
(OverseerAutoScalingTriggerThread-72124409025921027-127.0.0.1:42103_solr-n_0000000000)
 [n:127.0.0.1:42103_solr    ] o.a.s.c.a.NodeLostTrigger Initial livenodes: 
[127.0.0.1:42103_solr]
   [junit4]   2> 703247 DEBUG 
(OverseerAutoScalingTriggerThread-72124409025921027-127.0.0.1:42103_solr-n_0000000000)
 [n:127.0.0.1:42103_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 1, lastZnodeVersion -1
   [junit4]   2> 703248 DEBUG 
(OverseerAutoScalingTriggerThread-72124409025921027-127.0.0.1:42103_solr-n_0000000000)
 [n:127.0.0.1:42103_solr    ] o.a.s.c.a.OverseerTriggerThread Processed trigger 
updates upto znodeVersion 1
   [junit4]   2> 703251 DEBUG (ScheduledTrigger-3589-thread-1) 
[n:127.0.0.1:42103_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: 1
   [junit4]   2> 703254 DEBUG 
(OverseerAutoScalingTriggerThread-72124409025921027-127.0.0.1:42103_solr-n_0000000000)
 [n:127.0.0.1:42103_solr    ] o.a.s.c.a.OverseerTriggerThread -- clean old 
nodeAdded markers
   [junit4]   2> 703255 DEBUG 
(OverseerAutoScalingTriggerThread-72124409025921027-127.0.0.1:42103_solr-n_0000000000)
 [n:127.0.0.1:42103_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 1, lastZnodeVersion 1
   [junit4]   2> 703277 INFO  (jetty-launcher-1718-thread-1) 
[n:127.0.0.1:42103_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_42103.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@48ec0480
   [junit4]   2> 703283 INFO  (jetty-launcher-1718-thread-1) 
[n:127.0.0.1:42103_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_42103.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@48ec0480
   [junit4]   2> 703283 INFO  (jetty-launcher-1718-thread-1) 
[n:127.0.0.1:42103_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_42103.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@48ec0480
   [junit4]   2> 703284 INFO  (jetty-launcher-1718-thread-1) 
[n:127.0.0.1:42103_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest_25C2A8FF59E8133E-001/tempDir-001/node1/.
   [junit4]   2> 703295 INFO  (zkConnectionManagerCallback-1736-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 703297 INFO  (zkConnectionManagerCallback-1740-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 703298 INFO  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[25C2A8FF59E8133E]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 703298 INFO  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[25C2A8FF59E8133E]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45711/solr ready
   [junit4]   2> 703300 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    
] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and 
.scheduled_maintenance triggers
   [junit4]   2> 703300 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    
] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode 
version 0
   [junit4]   2> 703302 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    
] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10008_solr]
   [junit4]   2> 703302 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion -1
   [junit4]   2> 703302 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    
] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 0
   [junit4]   2> 703306 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    
] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 703309 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion 0
   [junit4]   2> 703309 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703314 INFO  
(TEST-ScheduledMaintenanceTriggerTest.testInactiveShardCleanup-seed#[25C2A8FF59E8133E])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testInactiveShardCleanup
   [junit4]   2> 703331 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703351 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703371 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703391 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703412 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703432 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703452 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703458 DEBUG (simCloudManagerPool-3595-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:10008_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> 703458 DEBUG (simCloudManagerPool-3595-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:10008_solr",
   [junit4]   2>     "base_url":"http://127.0.0.1:10008/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> 703458 DEBUG (simCloudManagerPool-3595-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:10008_solr",
   [junit4]   2>     "base_url":"http://127.0.0.1:10008/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> 703460 DEBUG (simCloudManagerPool-3595-thread-7) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 703460 DEBUG (simCloudManagerPool-3595-thread-7) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
1
   [junit4]   2> 703460 DEBUG (simCloudManagerPool-3595-thread-7) [    ] 
o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10008_solr]
   [junit4]   2> 703460 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    
] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
   [junit4]   2> 703461 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    
] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 703461 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
   [junit4]   2> 703471 DEBUG (simCloudManagerPool-3595-thread-8) [    ] 
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 703472 DEBUG (simCloudManagerPool-3595-thread-8) [    ] 
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 
2
   [junit4]   2> 703472 DEBUG (simCloudManagerPool-3595-thread-8) [    ] 
o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10008_solr]
   [junit4]   2> 703472 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    
] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2
   [junit4]   2> 703472 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    
] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 703472 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2
   [junit4]   2> 703472 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:11:50.943Z. Now: 2018-03-12T19:54:17.918Z
   [junit4]   2> 703472 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703473 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba0449fT1fhp2n37msuh9zv2y9y6yrqhc",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881910943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884457918},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 703492 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703494 WARN  (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:11:52.943Z. Now: 2018-03-12T19:54:18.988Z
   [junit4]   2> 703494 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba04c6fT1fhp2n37msuh9zv2y9y6yrqhe",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881912943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884458988},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 703513 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703515 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:11:54.943Z. Now: 2018-03-12T19:54:20.035Z
   [junit4]   2> 703515 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba0543fT1fhp2n37msuh9zv2y9y6yrqhg",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881914943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884460035},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 703533 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703535 WARN  (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:11:56.943Z. Now: 2018-03-12T19:54:21.072Z
   [junit4]   2> 703536 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba05c0fT1fhp2n37msuh9zv2y9y6yrqhi",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881916943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884461072},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 703553 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703556 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:11:58.943Z. Now: 2018-03-12T19:54:22.116Z
   [junit4]   2> 703556 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba063dfT1fhp2n37msuh9zv2y9y6yrqhk",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881918943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884462116},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 703573 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703577 WARN  (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:00.943Z. Now: 2018-03-12T19:54:23.149Z
   [junit4]   2> 703577 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba06bafT1fhp2n37msuh9zv2y9y6yrqhm",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881920943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884463149},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 703594 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703598 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:02.943Z. Now: 2018-03-12T19:54:24.191Z
   [junit4]   2> 703598 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba0737fT1fhp2n37msuh9zv2y9y6yrqho",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881922943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884464191},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 703614 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703618 WARN  (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:04.943Z. Now: 2018-03-12T19:54:25.223Z
   [junit4]   2> 703619 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba07b4fT1fhp2n37msuh9zv2y9y6yrqhq",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881924943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884465223},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 703634 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703639 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:06.943Z. Now: 2018-03-12T19:54:26.262Z
   [junit4]   2> 703639 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba0831fT1fhp2n37msuh9zv2y9y6yrqhs",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881926943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884466262},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 703654 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703660 WARN  (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:08.943Z. Now: 2018-03-12T19:54:27.293Z
   [junit4]   2> 703660 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba08aefT1fhp2n37msuh9zv2y9y6yrqhu",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881928943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884467293},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 703675 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703680 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:10.943Z. Now: 2018-03-12T19:54:28.334Z
   [junit4]   2> 703681 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba092bfT1fhp2n37msuh9zv2y9y6yrqhw",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881930943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884468334},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 703695 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703701 WARN  (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:12.943Z. Now: 2018-03-12T19:54:29.370Z
   [junit4]   2> 703701 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba09a8fT1fhp2n37msuh9zv2y9y6yrqhy",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881932943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884469370},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 703715 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703722 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:14.943Z. Now: 2018-03-12T19:54:30.411Z
   [junit4]   2> 703722 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba0a25fT1fhp2n37msuh9zv2y9y6yrqi0",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881934943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884470411},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 703735 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703743 WARN  (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:16.943Z. Now: 2018-03-12T19:54:31.458Z
   [junit4]   2> 703743 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba0aa2fT1fhp2n37msuh9zv2y9y6yrqi2",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881936943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884471458},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 703755 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703764 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:18.943Z. Now: 2018-03-12T19:54:32.508Z
   [junit4]   2> 703764 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba0b1ffT1fhp2n37msuh9zv2y9y6yrqi4",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881938943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884472508},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 703776 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703785 WARN  (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:20.943Z. Now: 2018-03-12T19:54:33.555Z
   [junit4]   2> 703785 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba0b9cfT1fhp2n37msuh9zv2y9y6yrqi6",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881940943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884473555},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 703796 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703806 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:22.943Z. Now: 2018-03-12T19:54:34.596Z
   [junit4]   2> 703806 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba0c19fT1fhp2n37msuh9zv2y9y6yrqi8",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881942943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884474596},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 703816 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703827 WARN  (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:24.943Z. Now: 2018-03-12T19:54:35.638Z
   [junit4]   2> 703827 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba0c96fT1fhp2n37msuh9zv2y9y6yrqia",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881944943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884475638},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 703836 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703847 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:26.943Z. Now: 2018-03-12T19:54:36.683Z
   [junit4]   2> 703848 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba0d13fT1fhp2n37msuh9zv2y9y6yrqic",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881946943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884476683},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 703856 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703868 WARN  (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:28.943Z. Now: 2018-03-12T19:54:37.721Z
   [junit4]   2> 703868 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba0d90fT1fhp2n37msuh9zv2y9y6yrqie",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881948943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884477721},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 703877 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703889 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:30.943Z. Now: 2018-03-12T19:54:38.756Z
   [junit4]   2> 703889 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba0e0dfT1fhp2n37msuh9zv2y9y6yrqig",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881950943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884478756},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 703897 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703910 WARN  (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:32.943Z. Now: 2018-03-12T19:54:39.791Z
   [junit4]   2> 703910 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba0e8afT1fhp2n37msuh9zv2y9y6yrqii",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881952943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884479791},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 703917 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703930 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:34.943Z. Now: 2018-03-12T19:54:40.824Z
   [junit4]   2> 703931 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba0f07fT1fhp2n37msuh9zv2y9y6yrqik",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881954943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884480824},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 703937 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703951 WARN  (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:36.943Z. Now: 2018-03-12T19:54:41.857Z
   [junit4]   2> 703951 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba0f84fT1fhp2n37msuh9zv2y9y6yrqim",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881956943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884481857},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 703958 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703972 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:38.943Z. Now: 2018-03-12T19:54:42.900Z
   [junit4]   2> 703972 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba1001fT1fhp2n37msuh9zv2y9y6yrqio",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881958943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884482900},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 703978 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 703993 WARN  (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:40.943Z. Now: 2018-03-12T19:54:43.940Z
   [junit4]   2> 703993 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba107efT1fhp2n37msuh9zv2y9y6yrqiq",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881960943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884483940},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 703998 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704014 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:42.943Z. Now: 2018-03-12T19:54:44.991Z
   [junit4]   2> 704014 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba10fbfT1fhp2n37msuh9zv2y9y6yrqis",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881962943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884484991},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704018 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704034 WARN  (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:44.943Z. Now: 2018-03-12T19:54:46.024Z
   [junit4]   2> 704035 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba1178fT1fhp2n37msuh9zv2y9y6yrqiu",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881964943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884486024},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704038 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704055 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:46.943Z. Now: 2018-03-12T19:54:47.068Z
   [junit4]   2> 704055 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba11f5fT1fhp2n37msuh9zv2y9y6yrqiw",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881966943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884487068},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704059 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704076 WARN  (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:48.943Z. Now: 2018-03-12T19:54:48.101Z
   [junit4]   2> 704076 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba1272fT1fhp2n37msuh9zv2y9y6yrqiy",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881968943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884488101},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704079 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704097 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:50.943Z. Now: 2018-03-12T19:54:49.141Z
   [junit4]   2> 704097 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba12effT1fhp2n37msuh9zv2y9y6yrqj0",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881970943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884489141},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704099 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704117 WARN  (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:52.943Z. Now: 2018-03-12T19:54:50.181Z
   [junit4]   2> 704118 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba136cfT1fhp2n37msuh9zv2y9y6yrqj2",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881972943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884490181},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704119 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704138 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:54.943Z. Now: 2018-03-12T19:54:51.224Z
   [junit4]   2> 704139 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba13e9fT1fhp2n37msuh9zv2y9y6yrqj4",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881974943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884491224},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704139 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704159 WARN  (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:56.943Z. Now: 2018-03-12T19:54:52.257Z
   [junit4]   2> 704159 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba1466fT1fhp2n37msuh9zv2y9y6yrqj6",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881976943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884492257},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704159 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704180 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704181 WARN  (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:12:58.943Z. Now: 2018-03-12T19:54:53.335Z
   [junit4]   2> 704181 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba14e3fT1fhp2n37msuh9zv2y9y6yrqj8",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881978943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884493335},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704200 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704201 WARN  (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:00.943Z. Now: 2018-03-12T19:54:54.366Z
   [junit4]   2> 704201 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba1560fT1fhp2n37msuh9zv2y9y6yrqja",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881980943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884494366},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704220 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704222 WARN  (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:02.943Z. Now: 2018-03-12T19:54:55.399Z
   [junit4]   2> 704222 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba15ddfT1fhp2n37msuh9zv2y9y6yrqjc",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881982943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884495399},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704240 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704243 WARN  (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:04.943Z. Now: 2018-03-12T19:54:56.436Z
   [junit4]   2> 704243 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba165afT1fhp2n37msuh9zv2y9y6yrqje",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881984943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884496436},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704252 DEBUG (ScheduledTrigger-3589-thread-3) 
[n:127.0.0.1:42103_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: 1
   [junit4]   2> 704260 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704263 WARN  (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:06.943Z. Now: 2018-03-12T19:54:57.466Z
   [junit4]   2> 704263 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba16d7fT1fhp2n37msuh9zv2y9y6yrqjg",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881986943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884497466},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704281 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704284 WARN  (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:08.943Z. Now: 2018-03-12T19:54:58.499Z
   [junit4]   2> 704284 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba1754fT1fhp2n37msuh9zv2y9y6yrqji",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881988943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884498499},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704301 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704305 WARN  (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:10.943Z. Now: 2018-03-12T19:54:59.536Z
   [junit4]   2> 704305 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba17d1fT1fhp2n37msuh9zv2y9y6yrqjk",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881990943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884499536},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704321 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704325 WARN  (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:12.943Z. Now: 2018-03-12T19:55:00.573Z
   [junit4]   2> 704326 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba184efT1fhp2n37msuh9zv2y9y6yrqjm",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881992943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884500573},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704341 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704346 WARN  (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:14.943Z. Now: 2018-03-12T19:55:01.610Z
   [junit4]   2> 704346 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba18cbfT1fhp2n37msuh9zv2y9y6yrqjo",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881994943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884501610},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704361 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704367 WARN  (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:16.943Z. Now: 2018-03-12T19:55:02.649Z
   [junit4]   2> 704367 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba1948fT1fhp2n37msuh9zv2y9y6yrqjq",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881996943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884502649},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704382 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704388 WARN  (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:18.943Z. Now: 2018-03-12T19:55:03.692Z
   [junit4]   2> 704388 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba19c5fT1fhp2n37msuh9zv2y9y6yrqjs",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520881998943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884503692},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704402 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704408 WARN  (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:20.943Z. Now: 2018-03-12T19:55:04.730Z
   [junit4]   2> 704409 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba1a42fT1fhp2n37msuh9zv2y9y6yrqju",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882000943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884504730},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704422 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704429 WARN  (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:22.943Z. Now: 2018-03-12T19:55:05.766Z
   [junit4]   2> 704429 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba1abffT1fhp2n37msuh9zv2y9y6yrqjw",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882002943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884505766},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704442 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704450 WARN  (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:24.943Z. Now: 2018-03-12T19:55:06.805Z
   [junit4]   2> 704450 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba1b3cfT1fhp2n37msuh9zv2y9y6yrqjy",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882004943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884506805},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704463 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704471 WARN  (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:26.943Z. Now: 2018-03-12T19:55:07.841Z
   [junit4]   2> 704471 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba1bb9fT1fhp2n37msuh9zv2y9y6yrqk0",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882006943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884507841},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704483 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704491 WARN  (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:28.943Z. Now: 2018-03-12T19:55:08.872Z
   [junit4]   2> 704491 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba1c36fT1fhp2n37msuh9zv2y9y6yrqk2",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882008943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884508872},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704503 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704512 WARN  (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:30.943Z. Now: 2018-03-12T19:55:09.904Z
   [junit4]   2> 704512 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba1cb3fT1fhp2n37msuh9zv2y9y6yrqk4",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882010943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884509904},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704523 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704533 WARN  (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:32.943Z. Now: 2018-03-12T19:55:10.941Z
   [junit4]   2> 704533 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba1d30fT1fhp2n37msuh9zv2y9y6yrqk6",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882012943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884510941},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704543 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704554 WARN  (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:34.943Z. Now: 2018-03-12T19:55:11.986Z
   [junit4]   2> 704554 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba1dadfT1fhp2n37msuh9zv2y9y6yrqk8",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882014943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884511986},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704564 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704574 WARN  (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:36.943Z. Now: 2018-03-12T19:55:13.020Z
   [junit4]   2> 704574 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba1e2afT1fhp2n37msuh9zv2y9y6yrqka",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882016943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884513020},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704584 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704595 WARN  (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:38.943Z. Now: 2018-03-12T19:55:14.054Z
   [junit4]   2> 704595 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba1ea7fT1fhp2n37msuh9zv2y9y6yrqkc",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882018943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884514054},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704604 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704616 WARN  (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:40.943Z. Now: 2018-03-12T19:55:15.094Z
   [junit4]   2> 704616 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba1f24fT1fhp2n37msuh9zv2y9y6yrqke",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882020943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884515094},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704624 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704636 WARN  (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:42.943Z. Now: 2018-03-12T19:55:16.134Z
   [junit4]   2> 704637 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba1fa1fT1fhp2n37msuh9zv2y9y6yrqkg",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882022943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884516134},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704644 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704660 WARN  (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:44.943Z. Now: 2018-03-12T19:55:17.286Z
   [junit4]   2> 704660 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba201efT1fhp2n37msuh9zv2y9y6yrqki",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882024943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884517286},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704665 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704684 WARN  (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:46.943Z. Now: 2018-03-12T19:55:18.504Z
   [junit4]   2> 704684 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba209bfT1fhp2n37msuh9zv2y9y6yrqkk",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882026943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884518504},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704685 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704705 WARN  (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:48.943Z. Now: 2018-03-12T19:55:19.543Z
   [junit4]   2> 704705 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba2118fT1fhp2n37msuh9zv2y9y6yrqkm",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882028943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884519543},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704705 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704725 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704731 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:50.943Z. Now: 2018-03-12T19:55:20.880Z
   [junit4]   2> 704732 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba2195fT1fhp2n37msuh9zv2y9y6yrqko",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882030943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884520880},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704746 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704752 WARN  (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:52.943Z. Now: 2018-03-12T19:55:21.918Z
   [junit4]   2> 704752 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba2212fT1fhp2n37msuh9zv2y9y6yrqkq",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882032943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884521918},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704766 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704773 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:54.943Z. Now: 2018-03-12T19:55:22.955Z
   [junit4]   2> 704773 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba228ffT1fhp2n37msuh9zv2y9y6yrqks",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882034943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884522955},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704786 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704794 WARN  (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:56.943Z. Now: 2018-03-12T19:55:23.992Z
   [junit4]   2> 704794 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba230cfT1fhp2n37msuh9zv2y9y6yrqku",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882036943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884523992},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704806 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704815 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:13:58.943Z. Now: 2018-03-12T19:55:25.068Z
   [junit4]   2> 704815 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba2389fT1fhp2n37msuh9zv2y9y6yrqkw",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882038943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884525068},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704826 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704836 WARN  (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:14:00.943Z. Now: 2018-03-12T19:55:26.122Z
   [junit4]   2> 704836 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba2406fT1fhp2n37msuh9zv2y9y6yrqky",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882040943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884526122},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704847 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704858 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:14:02.943Z. Now: 2018-03-12T19:55:27.188Z
   [junit4]   2> 704858 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba2483fT1fhp2n37msuh9zv2y9y6yrql0",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882042943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884527188},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704867 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704878 WARN  (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:14:04.943Z. Now: 2018-03-12T19:55:28.226Z
   [junit4]   2> 704879 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba2500fT1fhp2n37msuh9zv2y9y6yrql2",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882044943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884528226},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704887 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704899 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:14:06.943Z. Now: 2018-03-12T19:55:29.262Z
   [junit4]   2> 704899 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba257dfT1fhp2n37msuh9zv2y9y6yrql4",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882046943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884529262},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704907 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704920 WARN  (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:14:08.943Z. Now: 2018-03-12T19:55:30.296Z
   [junit4]   2> 704920 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba25fafT1fhp2n37msuh9zv2y9y6yrql6",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882048943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884530296},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704927 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704940 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:14:10.943Z. Now: 2018-03-12T19:55:31.333Z
   [junit4]   2> 704941 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba2677fT1fhp2n37msuh9zv2y9y6yrql8",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882050943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884531333},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704948 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704961 WARN  (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:14:12.943Z. Now: 2018-03-12T19:55:32.366Z
   [junit4]   2> 704961 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba26f4fT1fhp2n37msuh9zv2y9y6yrqla",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882052943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884532366},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704968 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 704982 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:14:14.943Z. Now: 2018-03-12T19:55:33.404Z
   [junit4]   2> 704982 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba2771fT1fhp2n37msuh9zv2y9y6yrqlc",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882054943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884533404},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 704988 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 705003 WARN  (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:14:16.943Z. Now: 2018-03-12T19:55:34.444Z
   [junit4]   2> 705003 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba27eefT1fhp2n37msuh9zv2y9y6yrqle",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882056943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884534444},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 705008 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 705023 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:14:18.943Z. Now: 2018-03-12T19:55:35.480Z
   [junit4]   2> 705024 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba286bfT1fhp2n37msuh9zv2y9y6yrqlg",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882058943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884535480},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 705028 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 705044 WARN  (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:14:20.943Z. Now: 2018-03-12T19:55:36.515Z
   [junit4]   2> 705044 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba28e8fT1fhp2n37msuh9zv2y9y6yrqli",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882060943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884536515},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 705048 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 705065 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:14:22.943Z. Now: 2018-03-12T19:55:37.550Z
   [junit4]   2> 705065 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba2965fT1fhp2n37msuh9zv2y9y6yrqlk",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882062943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884537550},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 705069 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 705086 WARN  (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:14:24.943Z. Now: 2018-03-12T19:55:38.585Z
   [junit4]   2> 705086 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba29e2fT1fhp2n37msuh9zv2y9y6yrqlm",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882064943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884538585},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 705089 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 705106 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:14:26.943Z. Now: 2018-03-12T19:55:39.620Z
   [junit4]   2> 705106 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba2a5ffT1fhp2n37msuh9zv2y9y6yrqlo",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882066943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884539620},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 705109 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 705127 WARN  (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:14:28.943Z. Now: 2018-03-12T19:55:40.659Z
   [junit4]   2> 705127 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba2adcfT1fhp2n37msuh9zv2y9y6yrqlq",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882068943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884540659},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 705129 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 705148 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:14:30.943Z. Now: 2018-03-12T19:55:41.696Z
   [junit4]   2> 705148 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba2b59fT1fhp2n37msuh9zv2y9y6yrqls",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882070943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884541696},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 705149 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 705168 WARN  (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:14:32.943Z. Now: 2018-03-12T19:55:42.728Z
   [junit4]   2> 705169 DEBUG (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba2bd6fT1fhp2n37msuh9zv2y9y6yrqlu",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882072943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884542728},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 705170 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 705189 WARN  (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:14:34.943Z. Now: 2018-03-12T19:55:43.760Z
   [junit4]   2> 705189 DEBUG (ScheduledTrigger-3596-thread-1) [    ] 
o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1621ba2c53fT1fhp2n37msuh9zv2y9y6yrqlw",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520882074943,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520884543760},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 705190 DEBUG (ScheduledTrigger-3596-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 705210 WARN  (ScheduledTrigger-3596-thread-4) [    ] 
o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at 
scheduled time: 2018-03-12T19:14:36.943Z. Now: 2018-03-12T19:55:44.797Z
   [junit4]   2> 705210 DEBUG (ScheduledTrigger-3596-thread-2) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1
   [junit4]   2> 705210 DEBUG (ScheduledTrigger-3596-th

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

 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=851488443
   [junit4]   2> 739063 INFO  (jetty-closer-1719-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 739063 INFO  (jetty-closer-1719-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@232b16cc: rootName = 
solr_42103, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@51019904
   [junit4]   2> 739069 INFO  (jetty-closer-1719-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 739069 INFO  (jetty-closer-1719-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@4fda9c6b: rootName = 
solr_42103, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@7f6e5ef0
   [junit4]   2> 739073 INFO  (jetty-closer-1719-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 739073 INFO  (jetty-closer-1719-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1d83d4ee: rootName = 
solr_42103, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@3f26ab5f
   [junit4]   2> 739074 INFO  (jetty-closer-1719-thread-1) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:42103_solr
   [junit4]   2> 739075 INFO  (jetty-closer-1719-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 739075 INFO  
(zkCallback-1728-thread-1-processing-n:127.0.0.1:42103_solr) 
[n:127.0.0.1:42103_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (0)
   [junit4]   2> 739075 INFO  (jetty-closer-1719-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 739075 INFO  
(zkCallback-1733-thread-1-processing-n:127.0.0.1:42103_solr) 
[n:127.0.0.1:42103_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (0)
   [junit4]   2> 739075 INFO  (jetty-closer-1719-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=72124409025921027-127.0.0.1:42103_solr-n_0000000000) closing
   [junit4]   2> 739075 INFO  
(OverseerStateUpdate-72124409025921027-127.0.0.1:42103_solr-n_0000000000) 
[n:127.0.0.1:42103_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:42103_solr
   [junit4]   2> 739075 WARN  
(OverseerAutoScalingTriggerThread-72124409025921027-127.0.0.1:42103_solr-n_0000000000)
 [n:127.0.0.1:42103_solr    ] o.a.s.c.a.OverseerTriggerThread 
OverseerTriggerThread woken up but we are closed, exiting.
   [junit4]   2> 739076 DEBUG (jetty-closer-1719-thread-1) [    ] 
o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
   [junit4]   2> 739076 INFO  (jetty-closer-1719-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@56f50bbd{/solr,null,UNAVAILABLE}
   [junit4]   2> 739077 INFO  (jetty-closer-1719-thread-1) [    ] 
o.e.j.s.session Stopped scavenging
   [junit4]   2> 739077 ERROR 
(SUITE-ScheduledMaintenanceTriggerTest-seed#[25C2A8FF59E8133E]-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> 739077 INFO  
(SUITE-ScheduledMaintenanceTriggerTest-seed#[25C2A8FF59E8133E]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:45711 45711
   [junit4]   2> 740673 INFO  (Thread-1688) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:45711 45711
   [junit4]   2> 740673 WARN  (Thread-1688) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        3       /solr/aliases.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        3       /solr/clusterstate.json
   [junit4]   2>        3       /solr/clusterprops.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        3       /solr/live_nodes
   [junit4]   2>        3       /solr/collections
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest_25C2A8FF59E8133E-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, 
docValues:{}, maxPointsInLeafNode=573, maxMBSortInHeap=7.23313273171662, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@7bd4c08),
 locale=es-NI, timezone=America/Indiana/Petersburg
   [junit4]   2> NOTE: Linux 4.13.0-36-generic amd64/Oracle Corporation 
1.8.0_162 (64-bit)/cpus=8,threads=1,free=154512424,total=518979584
   [junit4]   2> NOTE: All tests run in this JVM: 
[TestPayloadCheckQParserPlugin, TestMultiWordSynonyms, CSVRequestHandlerTest, 
TestFoldingMultitermQuery, TestObjectReleaseTracker, FacetPivotSmallTest, 
TestOnReconnectListenerSupport, TestLegacyNumericRangeQueryBuilder, 
ImplicitSnitchTest, ScriptEngineTest, MetricsHandlerTest, 
ChangedSchemaMergeTest, ConcurrentDeleteAndCreateCollectionTest, 
RemoteQueryErrorTest, TestCloudInspectUtil, TestSlowCompositeReaderWrapper, 
CursorMarkTest, AddBlockUpdateTest, TestLeaderInitiatedRecoveryThread, 
TestUniqueKeyFieldResource, TestSolrIndexConfig, TestReplicationHandlerBackup, 
TestBM25SimilarityFactory, PeerSyncTest, HLLUtilTest, TestNumericRangeQuery32, 
GraphQueryTest, TestSystemIdResolver, TestPartialUpdateDeduplication, 
RequiredFieldsTest, HttpPartitionTest, CollectionsAPISolrJTest, 
DeleteReplicaTest, SpatialRPTFieldTypeTest, TestQueryUtils, 
ExecutePlanActionTest, TestCollectionsAPIViaSolrCloudCluster, 
ResponseBuilderTest, TestSkipOverseerOperations, TestRebalanceLeaders, 
ResponseHeaderTest, CdcrBidirectionalTest, IndexSchemaTest, 
TestImplicitCoreProperties, TestRecovery, TestClusterProperties, 
TestCustomDocTransformer, BasicZkTest, TestSubQueryTransformerCrossCore, 
HighlighterTest, TestSimpleTextCodec, TestTestInjection, 
TestBackupRepositoryFactory, TestSortableTextField, TestAuthorizationFramework, 
XsltUpdateRequestHandlerTest, ChaosMonkeySafeLeaderWithPullReplicasTest, 
TestExactSharedStatsCache, TestCloudSchemaless, DistributedMLTComponentTest, 
TestTrie, TestDistributedGrouping, TestNRTOpen, TestManagedSchema, 
CustomHighlightComponentTest, TestClusterStateMutator, 
TestSweetSpotSimilarityFactory, SoftAutoCommitTest, 
TestTolerantUpdateProcessorRandomCloud, TestNodeAddedTrigger, 
CdcrReplicationHandlerTest, TestExecutePlanAction, QueryParsingTest, 
DistributedQueueTest, DistributedIntervalFacetingTest, TestConfigReload, 
ConfigureRecoveryStrategyTest, TestStressVersions, CloudMLTQParserTest, 
TestSha256AuthenticationProvider, TestCharFilters, JsonLoaderTest, 
ScheduledMaintenanceTriggerTest]
   [junit4] Completed [253/785 (1!)] on J1 in 37.62s, 2 tests, 1 failure <<< 
FAILURES!

[...truncated 47834 lines...]
-ecj-javadoc-lint-tests:
    [mkdir] Created dir: /tmp/ecj1141206264
 [ecj-lint] Compiling 878 source files to /tmp/ecj1141206264
 [ecj-lint] invalid Class-Path header in manifest of jar file: 
/home/jenkins/.ivy2/cache/org.restlet.jee/org.restlet/jars/org.restlet-2.3.0.jar
 [ecj-lint] invalid Class-Path header in manifest of jar file: 
/home/jenkins/.ivy2/cache/org.restlet.jee/org.restlet.ext.servlet/jars/org.restlet.ext.servlet-2.3.0.jar
 [ecj-lint] ----------
 [ecj-lint] 1. WARNING in 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test/org/apache/solr/analysis/TokenizerChainTest.java
 (at line 37)
 [ecj-lint]     TokenizerChain tokenizerChain = new TokenizerChain(
 [ecj-lint]                    ^^^^^^^^^^^^^^
 [ecj-lint] Resource leak: 'tokenizerChain' is never closed
 [ecj-lint] ----------
 [ecj-lint] ----------
 [ecj-lint] 2. ERROR in 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test/org/apache/solr/cloud/SSLMigrationTest.java
 (at line 21)
 [ecj-lint]     import org.apache.lucene.util.LuceneTestCase.BadApple;
 [ecj-lint]            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
 [ecj-lint] The import org.apache.lucene.util.LuceneTestCase.BadApple is never 
used
 [ecj-lint] ----------
 [ecj-lint] 2 problems (1 error, 1 warning)

BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:618: The following 
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:101: The following 
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build.xml:682: The 
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:2088: 
The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:2121: 
Compile failed; see the compiler error output for details.

Total time: 85 minutes 1 second
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to