Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/21601/ Java: 64bit/jdk-9.0.4 -XX:+UseCompressedOops -XX:+UseG1GC
3 tests failed. FAILED: org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest.testInactiveShardCleanup Error Message: should be at least one inactive event Stack Trace: java.lang.AssertionError: should be at least one inactive event at __randomizedtesting.SeedInfo.seed([123836403BDEB6B7:F14F6325A9D91BC]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest.testInactiveShardCleanup(ScheduledMaintenanceTriggerTest.java:218) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.base/java.lang.Thread.run(Thread.java:844) FAILED: org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest.testInactiveShardCleanup Error Message: should be at least one inactive event Stack Trace: java.lang.AssertionError: should be at least one inactive event at __randomizedtesting.SeedInfo.seed([123836403BDEB6B7:F14F6325A9D91BC]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest.testInactiveShardCleanup(ScheduledMaintenanceTriggerTest.java:218) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.base/java.lang.Thread.run(Thread.java:844) FAILED: org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest.testInactiveShardCleanup Error Message: cleanup action didn't run Stack Trace: java.lang.AssertionError: cleanup action didn't run at __randomizedtesting.SeedInfo.seed([123836403BDEB6B7:F14F6325A9D91BC]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest.testInactiveShardCleanup(ScheduledMaintenanceTriggerTest.java:197) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.base/java.lang.Thread.run(Thread.java:844) Build Log: [...truncated 14226 lines...] [junit4] Suite: org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest [junit4] 2> 2127768 INFO (SUITE-ScheduledMaintenanceTriggerTest-seed#[123836403BDEB6B7]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest_123836403BDEB6B7-001/init-core-data-001 [junit4] 2> 2127768 WARN (SUITE-ScheduledMaintenanceTriggerTest-seed#[123836403BDEB6B7]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=66 numCloses=66 [junit4] 2> 2127769 INFO (SUITE-ScheduledMaintenanceTriggerTest-seed#[123836403BDEB6B7]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true [junit4] 2> 2127769 INFO (SUITE-ScheduledMaintenanceTriggerTest-seed#[123836403BDEB6B7]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0) [junit4] 2> 2127770 INFO (SUITE-ScheduledMaintenanceTriggerTest-seed#[123836403BDEB6B7]-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_123836403BDEB6B7-001/tempDir-001 [junit4] 2> 2127770 INFO (SUITE-ScheduledMaintenanceTriggerTest-seed#[123836403BDEB6B7]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 2127770 INFO (Thread-6733) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 2127770 INFO (Thread-6733) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 2127771 ERROR (Thread-6733) [ ] 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> 2127870 INFO (SUITE-ScheduledMaintenanceTriggerTest-seed#[123836403BDEB6B7]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:38819 [junit4] 2> 2127872 INFO (zkConnectionManagerCallback-4844-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2127875 INFO (jetty-launcher-4841-thread-1) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T10:27:37+13:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 2127876 INFO (jetty-launcher-4841-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 2127876 INFO (jetty-launcher-4841-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2127876 INFO (jetty-launcher-4841-thread-1) [ ] o.e.j.s.session Scavenging every 600000ms [junit4] 2> 2127876 INFO (jetty-launcher-4841-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4edf528{/solr,null,AVAILABLE} [junit4] 2> 2127878 INFO (jetty-launcher-4841-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@34c0f75f{SSL,[ssl, http/1.1]}{127.0.0.1:32873} [junit4] 2> 2127878 INFO (jetty-launcher-4841-thread-1) [ ] o.e.j.s.Server Started @2130453ms [junit4] 2> 2127878 INFO (jetty-launcher-4841-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=32873} [junit4] 2> 2127878 ERROR (jetty-launcher-4841-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2127878 INFO (jetty-launcher-4841-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.0.0 [junit4] 2> 2127878 INFO (jetty-launcher-4841-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2127878 INFO (jetty-launcher-4841-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2127878 INFO (jetty-launcher-4841-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-09T09:31:49.135558Z [junit4] 2> 2127879 INFO (zkConnectionManagerCallback-4846-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2127879 INFO (jetty-launcher-4841-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 2127883 INFO (jetty-launcher-4841-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:38819/solr [junit4] 2> 2127883 INFO (zkConnectionManagerCallback-4850-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2127885 INFO (zkConnectionManagerCallback-4852-thread-1-processing-n:127.0.0.1:32873_solr) [n:127.0.0.1:32873_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2127913 INFO (jetty-launcher-4841-thread-1) [n:127.0.0.1:32873_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2127913 INFO (jetty-launcher-4841-thread-1) [n:127.0.0.1:32873_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:32873_solr [junit4] 2> 2127914 INFO (jetty-launcher-4841-thread-1) [n:127.0.0.1:32873_solr ] o.a.s.c.Overseer Overseer (id=72105141462499331-127.0.0.1:32873_solr-n_0000000000) starting [junit4] 2> 2127916 INFO (jetty-launcher-4841-thread-1) [n:127.0.0.1:32873_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:32873_solr [junit4] 2> 2127916 DEBUG (OverseerAutoScalingTriggerThread-72105141462499331-127.0.0.1:32873_solr-n_0000000000) [n:127.0.0.1:32873_solr ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and .scheduled_maintenance triggers [junit4] 2> 2127916 INFO (zkCallback-4851-thread-1-processing-n:127.0.0.1:32873_solr) [n:127.0.0.1:32873_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 2127916 DEBUG (OverseerAutoScalingTriggerThread-72105141462499331-127.0.0.1:32873_solr-n_0000000000) [n:127.0.0.1:32873_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1 [junit4] 2> 2127917 DEBUG (OverseerAutoScalingTriggerThread-72105141462499331-127.0.0.1:32873_solr-n_0000000000) [n:127.0.0.1:32873_solr ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:32873_solr] [junit4] 2> 2127917 DEBUG (OverseerAutoScalingTriggerThread-72105141462499331-127.0.0.1:32873_solr-n_0000000000) [n:127.0.0.1:32873_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion -1 [junit4] 2> 2127917 DEBUG (OverseerAutoScalingTriggerThread-72105141462499331-127.0.0.1:32873_solr-n_0000000000) [n:127.0.0.1:32873_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1 [junit4] 2> 2127918 DEBUG (OverseerAutoScalingTriggerThread-72105141462499331-127.0.0.1:32873_solr-n_0000000000) [n:127.0.0.1:32873_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers [junit4] 2> 2127918 DEBUG (ScheduledTrigger-9184-thread-1) [n:127.0.0.1:32873_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2127918 DEBUG (OverseerAutoScalingTriggerThread-72105141462499331-127.0.0.1:32873_solr-n_0000000000) [n:127.0.0.1:32873_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1 [junit4] 2> 2127950 INFO (jetty-launcher-4841-thread-1) [n:127.0.0.1:32873_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_32873.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1cf8eaa1 [junit4] 2> 2127955 INFO (jetty-launcher-4841-thread-1) [n:127.0.0.1:32873_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_32873.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1cf8eaa1 [junit4] 2> 2127955 INFO (jetty-launcher-4841-thread-1) [n:127.0.0.1:32873_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_32873.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1cf8eaa1 [junit4] 2> 2127956 INFO (jetty-launcher-4841-thread-1) [n:127.0.0.1:32873_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_123836403BDEB6B7-001/tempDir-001/node1/. [junit4] 2> 2127964 INFO (zkConnectionManagerCallback-4856-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2127966 INFO (zkConnectionManagerCallback-4860-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2127967 INFO (SUITE-ScheduledMaintenanceTriggerTest-seed#[123836403BDEB6B7]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 2127967 INFO (SUITE-ScheduledMaintenanceTriggerTest-seed#[123836403BDEB6B7]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:38819/solr ready [junit4] 2> 2127969 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and .scheduled_maintenance triggers [junit4] 2> 2127969 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 0 [junit4] 2> 2127969 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10016_solr] [junit4] 2> 2127969 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion -1 [junit4] 2> 2127969 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 0 [junit4] 2> 2127970 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers [junit4] 2> 2127971 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion 0 [junit4] 2> 2127971 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2127971 WARN (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:31:49.226Z. Now: 2018-03-10T11:21:58.849Z [junit4] 2> 2127972 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f40846aT4wgzf6ais2i1wvyx13mjcs6dj", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674309226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680918849}, [junit4] 2> "ignored":true} [junit4] 2> 2127974 INFO (TEST-ScheduledMaintenanceTriggerTest.testTriggerDefaults-seed#[123836403BDEB6B7]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testTriggerDefaults [junit4] 2> 2127974 INFO (TEST-ScheduledMaintenanceTriggerTest.testTriggerDefaults-seed#[123836403BDEB6B7]) [ ] o.a.s.c.a.ScheduledMaintenanceTriggerTest { [junit4] 2> "cluster-preferences":[ [junit4] 2> { [junit4] 2> "minimize":"cores", [junit4] 2> "precision":1}, [junit4] 2> {"maximize":"freedisk"}], [junit4] 2> "triggers":{ [junit4] 2> ".scheduled_maintenance":{ [junit4] 2> "name":".scheduled_maintenance", [junit4] 2> "startTime":"NOW", [junit4] 2> "event":"scheduled", [junit4] 2> "every":"+1DAY", [junit4] 2> "actions":[ [junit4] 2> { [junit4] 2> "name":"inactive_shard_plan", [junit4] 2> "class":"solr.InactiveShardPlanAction"}, [junit4] 2> { [junit4] 2> "name":"execute_plan", [junit4] 2> "class":"solr.ExecutePlanAction"}], [junit4] 2> "enabled":true}, [junit4] 2> ".auto_add_replicas":{ [junit4] 2> "name":".auto_add_replicas", [junit4] 2> "event":"nodeLost", [junit4] 2> "waitFor":30, [junit4] 2> "actions":[ [junit4] 2> { [junit4] 2> "name":"auto_add_replicas_plan", [junit4] 2> "class":"solr.AutoAddReplicasPlanAction"}, [junit4] 2> { [junit4] 2> "name":"execute_plan", [junit4] 2> "class":"solr.ExecutePlanAction"}], [junit4] 2> "enabled":true}}, [junit4] 2> "listeners":{ [junit4] 2> ".scheduled_maintenance.system":{ [junit4] 2> "trigger":".scheduled_maintenance", [junit4] 2> "afterAction":[], [junit4] 2> "stage":[ [junit4] 2> "STARTED", [junit4] 2> "ABORTED", [junit4] 2> "SUCCEEDED", [junit4] 2> "FAILED", [junit4] 2> "BEFORE_ACTION", [junit4] 2> "AFTER_ACTION", [junit4] 2> "IGNORED"], [junit4] 2> "class":"org.apache.solr.cloud.autoscaling.SystemLogListener", [junit4] 2> "beforeAction":[]}, [junit4] 2> ".auto_add_replicas.system":{ [junit4] 2> "trigger":".auto_add_replicas", [junit4] 2> "afterAction":[], [junit4] 2> "stage":[ [junit4] 2> "STARTED", [junit4] 2> "ABORTED", [junit4] 2> "SUCCEEDED", [junit4] 2> "FAILED", [junit4] 2> "BEFORE_ACTION", [junit4] 2> "AFTER_ACTION", [junit4] 2> "IGNORED"], [junit4] 2> "class":"org.apache.solr.cloud.autoscaling.SystemLogListener", [junit4] 2> "beforeAction":[]}}, [junit4] 2> "properties":{}} [junit4] 2> 2127975 DEBUG (simCloudManagerPool-9190-thread-2) [ ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration [junit4] 2> 2127975 DEBUG (simCloudManagerPool-9190-thread-2) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1 [junit4] 2> 2127975 DEBUG (simCloudManagerPool-9190-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10016_solr] [junit4] 2> 2127975 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1 [junit4] 2> 2127975 INFO (TEST-ScheduledMaintenanceTriggerTest.testTriggerDefaults-seed#[123836403BDEB6B7]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testTriggerDefaults [junit4] 2> 2127975 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers [junit4] 2> 2127975 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1 [junit4] 2> 2127979 INFO (TEST-ScheduledMaintenanceTriggerTest.testInactiveShardCleanup-seed#[123836403BDEB6B7]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testInactiveShardCleanup [junit4] 2> 2127991 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128011 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128032 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128052 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128072 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128092 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128112 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128123 DEBUG (simCloudManagerPool-9190-thread-6) [ ] o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for ScheduledMaintenanceTriggerTest_collection1 / shard1: {"core_node1":{ [junit4] 2> "node_name":"127.0.0.1:10016_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> 2128124 DEBUG (simCloudManagerPool-9190-thread-8) [ ] 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:10016_solr", [junit4] 2> "base_url":"http://127.0.0.1:10016/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> 2128124 DEBUG (simCloudManagerPool-9190-thread-7) [ ] 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:10016_solr", [junit4] 2> "base_url":"http://127.0.0.1:10016/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> 2128126 DEBUG (simCloudManagerPool-9190-thread-9) [ ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration [junit4] 2> 2128127 DEBUG (simCloudManagerPool-9190-thread-9) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 2 [junit4] 2> 2128127 DEBUG (simCloudManagerPool-9190-thread-9) [ ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10016_solr] [junit4] 2> 2128127 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2 [junit4] 2> 2128127 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers [junit4] 2> 2128127 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2 [junit4] 2> 2128128 DEBUG (simCloudManagerPool-9190-thread-10) [ ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration [junit4] 2> 2128128 DEBUG (simCloudManagerPool-9190-thread-10) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 3 [junit4] 2> 2128128 DEBUG (simCloudManagerPool-9190-thread-10) [ ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10016_solr] [junit4] 2> 2128128 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 3 [junit4] 2> 2128128 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers [junit4] 2> 2128128 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:31:51.226Z. Now: 2018-03-10T11:22:06.732Z [junit4] 2> 2128128 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3, lastZnodeVersion 3 [junit4] 2> 2128128 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f408c3aT4wgzf6ais2i1wvyx13mjcs6dl", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674311226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680926732}, [junit4] 2> "ignored":true} [junit4] 2> 2128133 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128151 WARN (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:31:53.226Z. Now: 2018-03-10T11:22:07.853Z [junit4] 2> 2128151 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f40940aT4wgzf6ais2i1wvyx13mjcs6dn", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674313226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680927853}, [junit4] 2> "ignored":true} [junit4] 2> 2128153 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128171 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:31:55.226Z. Now: 2018-03-10T11:22:08.890Z [junit4] 2> 2128172 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f409bdaT4wgzf6ais2i1wvyx13mjcs6dp", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674315226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680928890}, [junit4] 2> "ignored":true} [junit4] 2> 2128173 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128192 WARN (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:31:57.226Z. Now: 2018-03-10T11:22:09.936Z [junit4] 2> 2128192 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f40a3aaT4wgzf6ais2i1wvyx13mjcs6dr", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674317226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680929936}, [junit4] 2> "ignored":true} [junit4] 2> 2128193 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128213 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:31:59.226Z. Now: 2018-03-10T11:22:10.977Z [junit4] 2> 2128213 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f40ab7aT4wgzf6ais2i1wvyx13mjcs6dt", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674319226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680930977}, [junit4] 2> "ignored":true} [junit4] 2> 2128213 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128234 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128234 WARN (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:01.226Z. Now: 2018-03-10T11:22:12.012Z [junit4] 2> 2128234 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f40b34aT4wgzf6ais2i1wvyx13mjcs6dv", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674321226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680932012}, [junit4] 2> "ignored":true} [junit4] 2> 2128254 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128254 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:03.226Z. Now: 2018-03-10T11:22:13.045Z [junit4] 2> 2128255 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f40bb1aT4wgzf6ais2i1wvyx13mjcs6dx", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674323226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680933045}, [junit4] 2> "ignored":true} [junit4] 2> 2128274 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128275 WARN (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:05.226Z. Now: 2018-03-10T11:22:14.077Z [junit4] 2> 2128275 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f40c2eaT4wgzf6ais2i1wvyx13mjcs6dz", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674325226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680934077}, [junit4] 2> "ignored":true} [junit4] 2> 2128294 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128296 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:07.226Z. Now: 2018-03-10T11:22:15.108Z [junit4] 2> 2128296 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f40cabaT4wgzf6ais2i1wvyx13mjcs6e1", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674327226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680935108}, [junit4] 2> "ignored":true} [junit4] 2> 2128314 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128316 WARN (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:09.226Z. Now: 2018-03-10T11:22:16.140Z [junit4] 2> 2128316 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f40d28aT4wgzf6ais2i1wvyx13mjcs6e3", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674329226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680936140}, [junit4] 2> "ignored":true} [junit4] 2> 2128334 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128337 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:11.226Z. Now: 2018-03-10T11:22:17.175Z [junit4] 2> 2128337 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f40da5aT4wgzf6ais2i1wvyx13mjcs6e5", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674331226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680937175}, [junit4] 2> "ignored":true} [junit4] 2> 2128355 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128358 WARN (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:13.226Z. Now: 2018-03-10T11:22:18.218Z [junit4] 2> 2128358 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f40e22aT4wgzf6ais2i1wvyx13mjcs6e7", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674333226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680938218}, [junit4] 2> "ignored":true} [junit4] 2> 2128375 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128379 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:15.226Z. Now: 2018-03-10T11:22:19.259Z [junit4] 2> 2128379 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f40e9faT4wgzf6ais2i1wvyx13mjcs6e9", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674335226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680939259}, [junit4] 2> "ignored":true} [junit4] 2> 2128395 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128399 WARN (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:17.226Z. Now: 2018-03-10T11:22:20.298Z [junit4] 2> 2128400 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f40f1caT4wgzf6ais2i1wvyx13mjcs6eb", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674337226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680940298}, [junit4] 2> "ignored":true} [junit4] 2> 2128415 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128420 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:19.226Z. Now: 2018-03-10T11:22:21.326Z [junit4] 2> 2128420 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f40f99aT4wgzf6ais2i1wvyx13mjcs6ed", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674339226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680941326}, [junit4] 2> "ignored":true} [junit4] 2> 2128435 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128441 WARN (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:21.226Z. Now: 2018-03-10T11:22:22.355Z [junit4] 2> 2128441 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f41016aT4wgzf6ais2i1wvyx13mjcs6ef", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674341226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680942355}, [junit4] 2> "ignored":true} [junit4] 2> 2128456 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128461 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:23.226Z. Now: 2018-03-10T11:22:23.391Z [junit4] 2> 2128462 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f41093aT4wgzf6ais2i1wvyx13mjcs6eh", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674343226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680943391}, [junit4] 2> "ignored":true} [junit4] 2> 2128476 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128482 WARN (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:25.226Z. Now: 2018-03-10T11:22:24.422Z [junit4] 2> 2128482 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f41110aT4wgzf6ais2i1wvyx13mjcs6ej", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674345226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680944422}, [junit4] 2> "ignored":true} [junit4] 2> 2128496 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128503 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:27.226Z. Now: 2018-03-10T11:22:25.457Z [junit4] 2> 2128503 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f4118daT4wgzf6ais2i1wvyx13mjcs6el", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674347226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680945457}, [junit4] 2> "ignored":true} [junit4] 2> 2128516 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128523 WARN (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:29.226Z. Now: 2018-03-10T11:22:26.484Z [junit4] 2> 2128523 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f4120aaT4wgzf6ais2i1wvyx13mjcs6en", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674349226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680946484}, [junit4] 2> "ignored":true} [junit4] 2> 2128537 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128544 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:31.226Z. Now: 2018-03-10T11:22:27.516Z [junit4] 2> 2128544 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f41287aT4wgzf6ais2i1wvyx13mjcs6ep", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674351226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680947516}, [junit4] 2> "ignored":true} [junit4] 2> 2128557 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128565 WARN (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:33.226Z. Now: 2018-03-10T11:22:28.551Z [junit4] 2> 2128565 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f41304aT4wgzf6ais2i1wvyx13mjcs6er", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674353226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680948551}, [junit4] 2> "ignored":true} [junit4] 2> 2128577 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128585 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:35.226Z. Now: 2018-03-10T11:22:29.583Z [junit4] 2> 2128585 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f41381aT4wgzf6ais2i1wvyx13mjcs6et", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674355226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680949583}, [junit4] 2> "ignored":true} [junit4] 2> 2128597 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128606 WARN (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:37.226Z. Now: 2018-03-10T11:22:30.622Z [junit4] 2> 2128606 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f413feaT4wgzf6ais2i1wvyx13mjcs6ev", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674357226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680950622}, [junit4] 2> "ignored":true} [junit4] 2> 2128617 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128627 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:39.226Z. Now: 2018-03-10T11:22:31.649Z [junit4] 2> 2128627 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f4147baT4wgzf6ais2i1wvyx13mjcs6ex", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674359226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680951649}, [junit4] 2> "ignored":true} [junit4] 2> 2128638 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128647 WARN (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:41.226Z. Now: 2018-03-10T11:22:32.679Z [junit4] 2> 2128647 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f414f8aT4wgzf6ais2i1wvyx13mjcs6ez", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674361226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680952679}, [junit4] 2> "ignored":true} [junit4] 2> 2128658 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128668 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:43.226Z. Now: 2018-03-10T11:22:33.715Z [junit4] 2> 2128668 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f41575aT4wgzf6ais2i1wvyx13mjcs6f1", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674363226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680953715}, [junit4] 2> "ignored":true} [junit4] 2> 2128678 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128689 WARN (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:45.226Z. Now: 2018-03-10T11:22:34.749Z [junit4] 2> 2128689 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f415f2aT4wgzf6ais2i1wvyx13mjcs6f3", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674365226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680954749}, [junit4] 2> "ignored":true} [junit4] 2> 2128698 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128709 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:47.226Z. Now: 2018-03-10T11:22:35.788Z [junit4] 2> 2128709 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f4166faT4wgzf6ais2i1wvyx13mjcs6f5", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674367226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680955788}, [junit4] 2> "ignored":true} [junit4] 2> 2128719 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128730 WARN (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:49.226Z. Now: 2018-03-10T11:22:36.829Z [junit4] 2> 2128730 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f416ecaT4wgzf6ais2i1wvyx13mjcs6f7", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674369226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680956829}, [junit4] 2> "ignored":true} [junit4] 2> 2128739 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128751 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:51.226Z. Now: 2018-03-10T11:22:37.868Z [junit4] 2> 2128751 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f41769aT4wgzf6ais2i1wvyx13mjcs6f9", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674371226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680957868}, [junit4] 2> "ignored":true} [junit4] 2> 2128759 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128771 WARN (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:53.226Z. Now: 2018-03-10T11:22:38.891Z [junit4] 2> 2128771 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f417e6aT4wgzf6ais2i1wvyx13mjcs6fb", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674373226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680958891}, [junit4] 2> "ignored":true} [junit4] 2> 2128779 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128792 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:55.226Z. Now: 2018-03-10T11:22:39.913Z [junit4] 2> 2128792 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f41863aT4wgzf6ais2i1wvyx13mjcs6fd", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674375226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680959913}, [junit4] 2> "ignored":true} [junit4] 2> 2128799 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128813 WARN (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:57.226Z. Now: 2018-03-10T11:22:40.951Z [junit4] 2> 2128813 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f418e0aT4wgzf6ais2i1wvyx13mjcs6ff", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674377226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680960951}, [junit4] 2> "ignored":true} [junit4] 2> 2128820 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128833 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:32:59.226Z. Now: 2018-03-10T11:22:41.984Z [junit4] 2> 2128833 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f4195daT4wgzf6ais2i1wvyx13mjcs6fh", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674379226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680961984}, [junit4] 2> "ignored":true} [junit4] 2> 2128840 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128854 WARN (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:01.226Z. Now: 2018-03-10T11:22:43.021Z [junit4] 2> 2128854 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f419daaT4wgzf6ais2i1wvyx13mjcs6fj", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674381226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680963021}, [junit4] 2> "ignored":true} [junit4] 2> 2128860 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128875 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:03.226Z. Now: 2018-03-10T11:22:44.054Z [junit4] 2> 2128875 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f41a57aT4wgzf6ais2i1wvyx13mjcs6fl", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674383226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680964054}, [junit4] 2> "ignored":true} [junit4] 2> 2128880 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128895 WARN (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:05.226Z. Now: 2018-03-10T11:22:45.075Z [junit4] 2> 2128895 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f41ad4aT4wgzf6ais2i1wvyx13mjcs6fn", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674385226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680965075}, [junit4] 2> "ignored":true} [junit4] 2> 2128900 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128915 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:07.226Z. Now: 2018-03-10T11:22:46.097Z [junit4] 2> 2128916 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f41b51aT4wgzf6ais2i1wvyx13mjcs6fp", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674387226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680966097}, [junit4] 2> "ignored":true} [junit4] 2> 2128919 DEBUG (ScheduledTrigger-9184-thread-3) [n:127.0.0.1:32873_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128921 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128936 WARN (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:09.226Z. Now: 2018-03-10T11:22:47.127Z [junit4] 2> 2128936 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f41bceaT4wgzf6ais2i1wvyx13mjcs6fr", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674389226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680967127}, [junit4] 2> "ignored":true} [junit4] 2> 2128941 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128957 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:11.226Z. Now: 2018-03-10T11:22:48.165Z [junit4] 2> 2128957 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f41c4baT4wgzf6ais2i1wvyx13mjcs6ft", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674391226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680968165}, [junit4] 2> "ignored":true} [junit4] 2> 2128961 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128977 WARN (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:13.226Z. Now: 2018-03-10T11:22:49.196Z [junit4] 2> 2128978 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f41cc8aT4wgzf6ais2i1wvyx13mjcs6fv", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674393226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680969196}, [junit4] 2> "ignored":true} [junit4] 2> 2128981 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2128998 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:15.226Z. Now: 2018-03-10T11:22:50.226Z [junit4] 2> 2128998 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f41d45aT4wgzf6ais2i1wvyx13mjcs6fx", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674395226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680970226}, [junit4] 2> "ignored":true} [junit4] 2> 2129001 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2129019 WARN (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:17.226Z. Now: 2018-03-10T11:22:51.263Z [junit4] 2> 2129019 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f41dc2aT4wgzf6ais2i1wvyx13mjcs6fz", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674397226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680971263}, [junit4] 2> "ignored":true} [junit4] 2> 2129022 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2129039 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:19.226Z. Now: 2018-03-10T11:22:52.297Z [junit4] 2> 2129040 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f41e3faT4wgzf6ais2i1wvyx13mjcs6g1", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674399226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680972297}, [junit4] 2> "ignored":true} [junit4] 2> 2129042 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2129060 WARN (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:21.226Z. Now: 2018-03-10T11:22:53.333Z [junit4] 2> 2129060 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f41ebcaT4wgzf6ais2i1wvyx13mjcs6g3", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674401226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680973333}, [junit4] 2> "ignored":true} [junit4] 2> 2129062 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2129081 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:23.226Z. Now: 2018-03-10T11:22:54.366Z [junit4] 2> 2129081 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f41f39aT4wgzf6ais2i1wvyx13mjcs6g5", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674403226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680974366}, [junit4] 2> "ignored":true} [junit4] 2> 2129082 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2129102 WARN (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:25.226Z. Now: 2018-03-10T11:22:55.400Z [junit4] 2> 2129102 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f41fb6aT4wgzf6ais2i1wvyx13mjcs6g7", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674405226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680975400}, [junit4] 2> "ignored":true} [junit4] 2> 2129102 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2129122 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:27.226Z. Now: 2018-03-10T11:22:56.437Z [junit4] 2> 2129122 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f42033aT4wgzf6ais2i1wvyx13mjcs6g9", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674407226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680976437}, [junit4] 2> "ignored":true} [junit4] 2> 2129123 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2129143 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2129143 WARN (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:29.226Z. Now: 2018-03-10T11:22:57.468Z [junit4] 2> 2129143 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f420b0aT4wgzf6ais2i1wvyx13mjcs6gb", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674409226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680977468}, [junit4] 2> "ignored":true} [junit4] 2> 2129163 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2129164 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:31.226Z. Now: 2018-03-10T11:22:58.499Z [junit4] 2> 2129164 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f4212daT4wgzf6ais2i1wvyx13mjcs6gd", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674411226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680978499}, [junit4] 2> "ignored":true} [junit4] 2> 2129183 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2129184 WARN (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:33.226Z. Now: 2018-03-10T11:22:59.527Z [junit4] 2> 2129184 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f421aaaT4wgzf6ais2i1wvyx13mjcs6gf", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674413226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680979527}, [junit4] 2> "ignored":true} [junit4] 2> 2129203 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2129205 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:35.226Z. Now: 2018-03-10T11:23:00.565Z [junit4] 2> 2129205 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f42227aT4wgzf6ais2i1wvyx13mjcs6gh", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674415226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680980565}, [junit4] 2> "ignored":true} [junit4] 2> 2129224 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2129225 WARN (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:37.226Z. Now: 2018-03-10T11:23:01.594Z [junit4] 2> 2129226 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f422a4aT4wgzf6ais2i1wvyx13mjcs6gj", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674417226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680981594}, [junit4] 2> "ignored":true} [junit4] 2> 2129244 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2129246 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:39.226Z. Now: 2018-03-10T11:23:02.624Z [junit4] 2> 2129246 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f42321aT4wgzf6ais2i1wvyx13mjcs6gl", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674419226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680982624}, [junit4] 2> "ignored":true} [junit4] 2> 2129264 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2129267 WARN (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:41.226Z. Now: 2018-03-10T11:23:03.661Z [junit4] 2> 2129267 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f4239eaT4wgzf6ais2i1wvyx13mjcs6gn", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674421226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680983661}, [junit4] 2> "ignored":true} [junit4] 2> 2129284 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2129287 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:43.226Z. Now: 2018-03-10T11:23:04.692Z [junit4] 2> 2129287 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f4241baT4wgzf6ais2i1wvyx13mjcs6gp", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674423226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680984692}, [junit4] 2> "ignored":true} [junit4] 2> 2129305 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2129308 WARN (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:45.226Z. Now: 2018-03-10T11:23:05.724Z [junit4] 2> 2129308 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f42498aT4wgzf6ais2i1wvyx13mjcs6gr", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674425226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680985724}, [junit4] 2> "ignored":true} [junit4] 2> 2129325 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2129329 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:47.226Z. Now: 2018-03-10T11:23:06.759Z [junit4] 2> 2129329 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f42515aT4wgzf6ais2i1wvyx13mjcs6gt", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674427226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680986759}, [junit4] 2> "ignored":true} [junit4] 2> 2129345 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2129349 WARN (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:49.226Z. Now: 2018-03-10T11:23:07.788Z [junit4] 2> 2129349 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f42592aT4wgzf6ais2i1wvyx13mjcs6gv", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674429226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680987788}, [junit4] 2> "ignored":true} [junit4] 2> 2129365 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2129370 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:51.226Z. Now: 2018-03-10T11:23:08.820Z [junit4] 2> 2129370 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f4260faT4wgzf6ais2i1wvyx13mjcs6gx", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674431226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680988820}, [junit4] 2> "ignored":true} [junit4] 2> 2129385 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2129390 WARN (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:53.226Z. Now: 2018-03-10T11:23:09.845Z [junit4] 2> 2129391 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f4268caT4wgzf6ais2i1wvyx13mjcs6gz", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674433226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680989845}, [junit4] 2> "ignored":true} [junit4] 2> 2129406 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2129411 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:55.226Z. Now: 2018-03-10T11:23:10.876Z [junit4] 2> 2129411 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f42709aT4wgzf6ais2i1wvyx13mjcs6h1", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674435226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680990876}, [junit4] 2> "ignored":true} [junit4] 2> 2129426 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2129432 WARN (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:57.226Z. Now: 2018-03-10T11:23:11.907Z [junit4] 2> 2129432 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f42786aT4wgzf6ais2i1wvyx13mjcs6h3", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674437226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680991907}, [junit4] 2> "ignored":true} [junit4] 2> 2129446 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2129452 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:33:59.226Z. Now: 2018-03-10T11:23:12.928Z [junit4] 2> 2129452 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f42803aT4wgzf6ais2i1wvyx13mjcs6h5", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674439226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680992928}, [junit4] 2> "ignored":true} [junit4] 2> 2129466 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2129473 WARN (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:34:01.226Z. Now: 2018-03-10T11:23:13.960Z [junit4] 2> 2129473 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f42880aT4wgzf6ais2i1wvyx13mjcs6h7", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674441226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680993960}, [junit4] 2> "ignored":true} [junit4] 2> 2129486 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2129494 WARN (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:34:03.226Z. Now: 2018-03-10T11:23:15.004Z [junit4] 2> 2129494 DEBUG (ScheduledTrigger-9191-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f428fdaT4wgzf6ais2i1wvyx13mjcs6h9", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674443226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680995004}, [junit4] 2> "ignored":true} [junit4] 2> 2129507 DEBUG (ScheduledTrigger-9191-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 2129514 WARN (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T09:34:05.226Z. Now: 2018-03-10T11:23:16.035Z [junit4] 2> 2129514 DEBUG (ScheduledTrigger-9191-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1620f4297aaT4wgzf6ais2i1wvyx13mjcs6hb", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520674445226, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520680996035}, [junit4] 2> "ignored":true} [junit4] 2> 2129527 DEBUG (ScheduledTrigger-9191-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently li [...truncated too long message...] ava:532) [junit4] 2> at org.apache.solr.cloud.autoscaling.ScheduledTriggers.lambda$add$3(ScheduledTriggers.java:317) [junit4] 2> at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:514) [junit4] 2> at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188) [junit4] 2> at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167) [junit4] 2> at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641) [junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> 6266 DEBUG (AutoscalingActionExecutor-29-thread-1) [ ] o.a.s.c.a.ScheduledTriggers Resuming trigger: .auto_add_replicas after 100ms [junit4] 2> 6266 DEBUG (AutoscalingActionExecutor-29-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -- processing took 101 ms for event id=294ebcbc45d13T4wgzf6ais2i1wvyx13mjcrqk5 [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ScheduledMaintenanceTriggerTest -Dtests.method=testInactiveShardCleanup -Dtests.seed=123836403BDEB6B7 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.badapples=true -Dtests.locale=zu -Dtests.timezone=Africa/Nairobi -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1 [junit4] FAILURE 0.16s J0 | ScheduledMaintenanceTriggerTest.testInactiveShardCleanup <<< [junit4] > Throwable #1: java.lang.AssertionError: should be at least one inactive event [junit4] > at __randomizedtesting.SeedInfo.seed([123836403BDEB6B7:F14F6325A9D91BC]:0) [junit4] > at org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest.testInactiveShardCleanup(ScheduledMaintenanceTriggerTest.java:218) [junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] > at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] > at java.base/java.lang.reflect.Method.invoke(Method.java:564) [junit4] > at java.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> 6267 WARN (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting. [junit4] 2> 6268 DEBUG (SUITE-ScheduledMaintenanceTriggerTest-seed#[123836403BDEB6B7]-worker) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly [junit4] 2> 6273 INFO (jetty-closer-22-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@31aff0df{SSL,[ssl, http/1.1]}{127.0.0.1:0} [junit4] 2> 6273 INFO (jetty-closer-22-thread-1) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=2106620055 [junit4] 2> 6273 INFO (jetty-closer-22-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 6274 INFO (jetty-closer-22-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2e9d5e12: rootName = solr_40755, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@3193f478 [junit4] 2> 6282 INFO (jetty-closer-22-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 6282 INFO (jetty-closer-22-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@671dc24e: rootName = solr_40755, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@18e73778 [junit4] 2> 6287 INFO (jetty-closer-22-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 6287 INFO (jetty-closer-22-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3a247c85: rootName = solr_40755, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@53ca4f56 [junit4] 2> 6289 INFO (jetty-closer-22-thread-1) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:40755_solr [junit4] 2> 6289 INFO (jetty-closer-22-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 6290 INFO (jetty-closer-22-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 6290 INFO (zkCallback-31-thread-1-processing-n:127.0.0.1:40755_solr) [n:127.0.0.1:40755_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0) [junit4] 2> 6290 INFO (jetty-closer-22-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72105211074445315-127.0.0.1:40755_solr-n_0000000000) closing [junit4] 2> 6291 INFO (OverseerStateUpdate-72105211074445315-127.0.0.1:40755_solr-n_0000000000) [n:127.0.0.1:40755_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:40755_solr [junit4] 2> 6291 WARN (OverseerAutoScalingTriggerThread-72105211074445315-127.0.0.1:40755_solr-n_0000000000) [n:127.0.0.1:40755_solr ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting. [junit4] 2> 6291 DEBUG (jetty-closer-22-thread-1) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly [junit4] 2> 6292 INFO (jetty-closer-22-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@489b63f4{/solr,null,UNAVAILABLE} [junit4] 2> 6292 INFO (jetty-closer-22-thread-1) [ ] o.e.j.s.session Stopped scavenging [junit4] 2> 6293 ERROR (SUITE-ScheduledMaintenanceTriggerTest-seed#[123836403BDEB6B7]-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> 6293 INFO (SUITE-ScheduledMaintenanceTriggerTest-seed#[123836403BDEB6B7]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:45467 45467 [junit4] 2> 6345 INFO (Thread-11) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:45467 45467 [junit4] 2> 6346 WARN (Thread-11) [ ] o.a.s.c.ZkTestServer Watch limit violations: [junit4] 2> Maximum concurrent create/delete watches above limit: [junit4] 2> [junit4] 2> 2 /solr/aliases.json [junit4] 2> [junit4] 2> Maximum concurrent data watches above limit: [junit4] 2> [junit4] 2> 2 /solr/clusterstate.json [junit4] 2> 2 /solr/clusterprops.json [junit4] 2> [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2> [junit4] 2> 2 /solr/live_nodes [junit4] 2> 2 /solr/collections [junit4] 2> [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest_123836403BDEB6B7-001 [junit4] 2> Mar 09, 2018 9:49:31 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 3 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70), sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@2791b05c), locale=zu, timezone=Africa/Nairobi [junit4] 2> NOTE: Linux 4.13.0-36-generic amd64/Oracle Corporation 9.0.4 (64-bit)/cpus=8,threads=1,free=348092856,total=536870912 [junit4] 2> NOTE: All tests run in this JVM: [ScheduledMaintenanceTriggerTest, ScheduledMaintenanceTriggerTest] [junit4] Completed [5/5 (2!)] on J0 in 0.88s, 2 tests, 1 failure <<< FAILURES! [...truncated 12 lines...] BUILD FAILED /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1561: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1085: There were test failures: 5 suites, 10 tests, 2 failures [seed: 123836403BDEB6B7] Total time: 10 seconds [repro] Setting last failure code to 256 [repro] Failures: [repro] 2/5 failed: org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest [repro] Exiting with code 256 + mv lucene/build lucene/build.repro + mv solr/build solr/build.repro + mv lucene/build.orig lucene/build + mv solr/build.orig solr/build Archiving artifacts Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 [WARNINGS] Parsing warnings in console log with parser Java Compiler (javac) Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 <Git Blamer> Using GitBlamer to create author and commit information for all warnings. <Git Blamer> GIT_COMMIT=7dfb04ee5e9f973fbad20c529ec091c201743398, workspace=/var/lib/jenkins/workspace/Lucene-Solr-master-Linux [WARNINGS] Computing warning deltas based on reference build #21600 Recording test results Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Build step 'Publish JUnit test result report' changed build result to UNSTABLE Email was triggered for: Unstable (Test Failures) Sending email for trigger: Unstable (Test Failures) Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org