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