Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/21633/ Java: 64bit/jdk-10-ea+43 -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([E51364AF66639CAA:F83FA4DD0720BBA1]: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([E51364AF66639CAA:F83FA4DD0720BBA1]: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([E51364AF66639CAA:F83FA4DD0720BBA1]: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 1846 lines...] [junit4] JVM J0: stdout was not empty, see: /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/build/core/test/temp/junit4-J0-20180313_123124_2084194796756965121523.sysout [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] codec: DummyCompressingStoredFields, pf: TestBloomFilteredLucenePostings, dvf: Memory [junit4] <<< JVM J0: EOF ---- [...truncated 11537 lines...] [junit4] Suite: org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest [junit4] 2> 1012896 INFO (SUITE-ScheduledMaintenanceTriggerTest-seed#[E51364AF66639CAA]-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_E51364AF66639CAA-001/init-core-data-001 [junit4] 2> 1012897 WARN (SUITE-ScheduledMaintenanceTriggerTest-seed#[E51364AF66639CAA]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1 [junit4] 2> 1012897 INFO (SUITE-ScheduledMaintenanceTriggerTest-seed#[E51364AF66639CAA]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=true [junit4] 2> 1012897 INFO (SUITE-ScheduledMaintenanceTriggerTest-seed#[E51364AF66639CAA]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0) [junit4] 2> 1012898 INFO (SUITE-ScheduledMaintenanceTriggerTest-seed#[E51364AF66639CAA]-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_E51364AF66639CAA-001/tempDir-001 [junit4] 2> 1012899 INFO (SUITE-ScheduledMaintenanceTriggerTest-seed#[E51364AF66639CAA]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 1012913 INFO (Thread-6222) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 1012913 INFO (Thread-6222) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 1012915 ERROR (Thread-6222) [ ] 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> 1013013 INFO (SUITE-ScheduledMaintenanceTriggerTest-seed#[E51364AF66639CAA]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:46651 [junit4] 2> 1013017 INFO (zkConnectionManagerCallback-4830-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1013020 INFO (jetty-launcher-4827-thread-1) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: ٢٠١٧-١١-٢٢T٠٨:٢٧:٣٧+11:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 1013022 INFO (jetty-launcher-4827-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 1013022 INFO (jetty-launcher-4827-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 1013022 INFO (jetty-launcher-4827-thread-1) [ ] o.e.j.s.session Scavenging every 660000ms [junit4] 2> 1013022 INFO (jetty-launcher-4827-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5d9bfb56{/solr,null,AVAILABLE} [junit4] 2> 1013024 INFO (jetty-launcher-4827-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@4ba01cf4{SSL,[ssl, http/1.1]}{127.0.0.1:36553} [junit4] 2> 1013024 INFO (jetty-launcher-4827-thread-1) [ ] o.e.j.s.Server Started @1015908ms [junit4] 2> 1013024 INFO (jetty-launcher-4827-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=36553} [junit4] 2> 1013024 ERROR (jetty-launcher-4827-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 1013024 INFO (jetty-launcher-4827-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0 [junit4] 2> 1013024 INFO (jetty-launcher-4827-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 1013024 INFO (jetty-launcher-4827-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 1013024 INFO (jetty-launcher-4827-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-13T13:14:39.440527Z [junit4] 2> 1013025 INFO (zkConnectionManagerCallback-4832-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1013025 INFO (jetty-launcher-4827-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 1013029 INFO (jetty-launcher-4827-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46651/solr [junit4] 2> 1013030 INFO (zkConnectionManagerCallback-4836-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1013031 INFO (zkConnectionManagerCallback-4838-thread-1-processing-n:127.0.0.1:36553_solr) [n:127.0.0.1:36553_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1013063 INFO (jetty-launcher-4827-thread-1) [n:127.0.0.1:36553_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 1013063 INFO (jetty-launcher-4827-thread-1) [n:127.0.0.1:36553_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:36553_solr [junit4] 2> 1013064 INFO (jetty-launcher-4827-thread-1) [n:127.0.0.1:36553_solr ] o.a.s.c.Overseer Overseer (id=72128666940276739-127.0.0.1:36553_solr-n_0000000000) starting [junit4] 2> 1013070 INFO (zkConnectionManagerCallback-4843-thread-1-processing-n:127.0.0.1:36553_solr) [n:127.0.0.1:36553_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1013071 INFO (jetty-launcher-4827-thread-1) [n:127.0.0.1:36553_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:46651/solr ready [junit4] 2> 1013072 INFO (jetty-launcher-4827-thread-1) [n:127.0.0.1:36553_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:36553_solr [junit4] 2> 1013072 DEBUG (OverseerAutoScalingTriggerThread-72128666940276739-127.0.0.1:36553_solr-n_0000000000) [n:127.0.0.1:36553_solr ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and .scheduled_maintenance triggers [junit4] 2> 1013072 INFO (zkCallback-4842-thread-1-processing-n:127.0.0.1:36553_solr) [n:127.0.0.1:36553_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 1013072 DEBUG (OverseerAutoScalingTriggerThread-72128666940276739-127.0.0.1:36553_solr-n_0000000000) [n:127.0.0.1:36553_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1 [junit4] 2> 1013073 DEBUG (OverseerAutoScalingTriggerThread-72128666940276739-127.0.0.1:36553_solr-n_0000000000) [n:127.0.0.1:36553_solr ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:36553_solr] [junit4] 2> 1013073 DEBUG (OverseerAutoScalingTriggerThread-72128666940276739-127.0.0.1:36553_solr-n_0000000000) [n:127.0.0.1:36553_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion -1 [junit4] 2> 1013073 DEBUG (OverseerAutoScalingTriggerThread-72128666940276739-127.0.0.1:36553_solr-n_0000000000) [n:127.0.0.1:36553_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1 [junit4] 2> 1013085 INFO (zkCallback-4837-thread-1-processing-n:127.0.0.1:36553_solr) [n:127.0.0.1:36553_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 1013107 DEBUG (ScheduledTrigger-5598-thread-1) [n:127.0.0.1:36553_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013115 INFO (jetty-launcher-4827-thread-1) [n:127.0.0.1:36553_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36553.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@49fc2501 [junit4] 2> 1013116 DEBUG (OverseerAutoScalingTriggerThread-72128666940276739-127.0.0.1:36553_solr-n_0000000000) [n:127.0.0.1:36553_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers [junit4] 2> 1013117 DEBUG (OverseerAutoScalingTriggerThread-72128666940276739-127.0.0.1:36553_solr-n_0000000000) [n:127.0.0.1:36553_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1 [junit4] 2> 1013123 INFO (jetty-launcher-4827-thread-1) [n:127.0.0.1:36553_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36553.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@49fc2501 [junit4] 2> 1013123 INFO (jetty-launcher-4827-thread-1) [n:127.0.0.1:36553_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36553.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@49fc2501 [junit4] 2> 1013124 INFO (jetty-launcher-4827-thread-1) [n:127.0.0.1:36553_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_E51364AF66639CAA-001/tempDir-001/node1/. [junit4] 2> 1013138 INFO (zkConnectionManagerCallback-4845-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1013146 INFO (zkConnectionManagerCallback-4849-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1013146 INFO (SUITE-ScheduledMaintenanceTriggerTest-seed#[E51364AF66639CAA]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 1013147 INFO (SUITE-ScheduledMaintenanceTriggerTest-seed#[E51364AF66639CAA]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:46651/solr ready [junit4] 2> 1013149 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and .scheduled_maintenance triggers [junit4] 2> 1013149 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 0 [junit4] 2> 1013151 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10009_solr] [junit4] 2> 1013151 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion -1 [junit4] 2> 1013151 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 0 [junit4] 2> 1013154 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers [junit4] 2> 1013157 INFO (TEST-ScheduledMaintenanceTriggerTest.testTriggerDefaults-seed#[E51364AF66639CAA]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testTriggerDefaults [junit4] 2> 1013157 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion 0 [junit4] 2> 1013157 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013157 INFO (TEST-ScheduledMaintenanceTriggerTest.testTriggerDefaults-seed#[E51364AF66639CAA]) [ ] 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":120, [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> 1013158 DEBUG (simCloudManagerPool-5604-thread-1) [ ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration [junit4] 2> 1013158 DEBUG (simCloudManagerPool-5604-thread-1) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1 [junit4] 2> 1013158 DEBUG (simCloudManagerPool-5604-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10009_solr] [junit4] 2> 1013158 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1 [junit4] 2> 1013159 INFO (TEST-ScheduledMaintenanceTriggerTest.testTriggerDefaults-seed#[E51364AF66639CAA]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testTriggerDefaults [junit4] 2> 1013162 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers [junit4] 2> 1013162 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1 [junit4] 2> 1013166 INFO (TEST-ScheduledMaintenanceTriggerTest.testInactiveShardCleanup-seed#[E51364AF66639CAA]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testInactiveShardCleanup [junit4] 2> 1013177 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013198 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013221 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013241 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013262 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013282 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013302 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013315 DEBUG (simCloudManagerPool-5604-thread-6) [ ] 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:10009_solr", [junit4] 2> "base_url":"http://127.0.0.1:10009/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> 1013315 DEBUG (simCloudManagerPool-5604-thread-7) [ ] 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:10009_solr", [junit4] 2> "base_url":"http://127.0.0.1:10009/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> 1013315 DEBUG (simCloudManagerPool-5604-thread-5) [ ] o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for ScheduledMaintenanceTriggerTest_collection1 / shard1: {"core_node1":{ [junit4] 2> "node_name":"127.0.0.1:10009_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> 1013319 DEBUG (simCloudManagerPool-5604-thread-8) [ ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration [junit4] 2> 1013319 DEBUG (simCloudManagerPool-5604-thread-8) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 2 [junit4] 2> 1013319 DEBUG (simCloudManagerPool-5604-thread-8) [ ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10009_solr] [junit4] 2> 1013319 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2 [junit4] 2> 1013320 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers [junit4] 2> 1013320 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2 [junit4] 2> 1013320 DEBUG (simCloudManagerPool-5604-thread-9) [ ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration [junit4] 2> 1013320 DEBUG (simCloudManagerPool-5604-thread-9) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 3 [junit4] 2> 1013321 DEBUG (simCloudManagerPool-5604-thread-9) [ ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10009_solr] [junit4] 2> 1013321 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 3 [junit4] 2> 1013321 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers [junit4] 2> 1013321 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3, lastZnodeVersion 3 [junit4] 2> 1013321 WARN (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:14:41.566Z. Now: 2018-03-13T19:34:17.016Z [junit4] 2> 1013321 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f7fa41eT74q2rv8c54d1igwhfs3hmphph", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946881566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969657016}, [junit4] 2> "ignored":true} [junit4] 2> 1013322 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013342 WARN (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:14:43.566Z. Now: 2018-03-13T19:34:18.086Z [junit4] 2> 1013342 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013343 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f7fabeeT74q2rv8c54d1igwhfs3hmphpj", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946883566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969658086}, [junit4] 2> "ignored":true} [junit4] 2> 1013363 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013363 WARN (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:14:45.566Z. Now: 2018-03-13T19:34:19.117Z [junit4] 2> 1013363 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f7fb3beT74q2rv8c54d1igwhfs3hmphpl", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946885566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969659117}, [junit4] 2> "ignored":true} [junit4] 2> 1013383 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013384 WARN (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:14:47.566Z. Now: 2018-03-13T19:34:20.160Z [junit4] 2> 1013384 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f7fbb8eT74q2rv8c54d1igwhfs3hmphpn", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946887566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969660160}, [junit4] 2> "ignored":true} [junit4] 2> 1013403 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013405 WARN (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:14:49.566Z. Now: 2018-03-13T19:34:21.200Z [junit4] 2> 1013405 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f7fc35eT74q2rv8c54d1igwhfs3hmphpp", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946889566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969661200}, [junit4] 2> "ignored":true} [junit4] 2> 1013423 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013426 WARN (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:14:51.566Z. Now: 2018-03-13T19:34:22.245Z [junit4] 2> 1013426 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f7fcb2eT74q2rv8c54d1igwhfs3hmphpr", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946891566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969662245}, [junit4] 2> "ignored":true} [junit4] 2> 1013444 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013446 WARN (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:14:53.566Z. Now: 2018-03-13T19:34:23.282Z [junit4] 2> 1013447 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f7fd2feT74q2rv8c54d1igwhfs3hmphpt", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946893566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969663282}, [junit4] 2> "ignored":true} [junit4] 2> 1013464 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013467 WARN (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:14:55.566Z. Now: 2018-03-13T19:34:24.333Z [junit4] 2> 1013467 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f7fdaceT74q2rv8c54d1igwhfs3hmphpv", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946895566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969664333}, [junit4] 2> "ignored":true} [junit4] 2> 1013484 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013488 WARN (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:14:57.566Z. Now: 2018-03-13T19:34:25.362Z [junit4] 2> 1013488 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f7fe29eT74q2rv8c54d1igwhfs3hmphpx", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946897566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969665362}, [junit4] 2> "ignored":true} [junit4] 2> 1013504 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013509 WARN (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:14:59.566Z. Now: 2018-03-13T19:34:26.395Z [junit4] 2> 1013509 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f7fea6eT74q2rv8c54d1igwhfs3hmphpz", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946899566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969666395}, [junit4] 2> "ignored":true} [junit4] 2> 1013525 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013529 WARN (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:01.566Z. Now: 2018-03-13T19:34:27.436Z [junit4] 2> 1013530 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f7ff23eT74q2rv8c54d1igwhfs3hmphq1", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946901566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969667436}, [junit4] 2> "ignored":true} [junit4] 2> 1013545 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013550 WARN (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:03.566Z. Now: 2018-03-13T19:34:28.473Z [junit4] 2> 1013550 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f7ffa0eT74q2rv8c54d1igwhfs3hmphq3", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946903566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969668473}, [junit4] 2> "ignored":true} [junit4] 2> 1013565 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013571 WARN (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:05.566Z. Now: 2018-03-13T19:34:29.532Z [junit4] 2> 1013572 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f8001deT74q2rv8c54d1igwhfs3hmphq5", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946905566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969669532}, [junit4] 2> "ignored":true} [junit4] 2> 1013585 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013592 WARN (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:07.566Z. Now: 2018-03-13T19:34:30.574Z [junit4] 2> 1013592 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f8009aeT74q2rv8c54d1igwhfs3hmphq7", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946907566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969670574}, [junit4] 2> "ignored":true} [junit4] 2> 1013606 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013613 WARN (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:09.566Z. Now: 2018-03-13T19:34:31.624Z [junit4] 2> 1013613 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f80117eT74q2rv8c54d1igwhfs3hmphq9", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946909566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969671624}, [junit4] 2> "ignored":true} [junit4] 2> 1013626 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013634 WARN (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:11.566Z. Now: 2018-03-13T19:34:32.666Z [junit4] 2> 1013634 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f80194eT74q2rv8c54d1igwhfs3hmphqb", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946911566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969672666}, [junit4] 2> "ignored":true} [junit4] 2> 1013646 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013655 WARN (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:13.566Z. Now: 2018-03-13T19:34:33.706Z [junit4] 2> 1013655 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f80211eT74q2rv8c54d1igwhfs3hmphqd", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946913566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969673706}, [junit4] 2> "ignored":true} [junit4] 2> 1013666 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013678 WARN (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:15.566Z. Now: 2018-03-13T19:34:34.847Z [junit4] 2> 1013678 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f8028eeT74q2rv8c54d1igwhfs3hmphqf", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946915566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969674847}, [junit4] 2> "ignored":true} [junit4] 2> 1013686 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013701 WARN (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:17.566Z. Now: 2018-03-13T19:34:36.019Z [junit4] 2> 1013701 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f8030beT74q2rv8c54d1igwhfs3hmphqh", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946917566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969676019}, [junit4] 2> "ignored":true} [junit4] 2> 1013707 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013722 WARN (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:19.566Z. Now: 2018-03-13T19:34:37.058Z [junit4] 2> 1013722 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f80388eT74q2rv8c54d1igwhfs3hmphqj", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946919566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969677058}, [junit4] 2> "ignored":true} [junit4] 2> 1013727 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013745 WARN (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:21.566Z. Now: 2018-03-13T19:34:38.216Z [junit4] 2> 1013745 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f80405eT74q2rv8c54d1igwhfs3hmphql", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946921566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969678216}, [junit4] 2> "ignored":true} [junit4] 2> 1013747 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013766 WARN (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:23.566Z. Now: 2018-03-13T19:34:39.259Z [junit4] 2> 1013766 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f80482eT74q2rv8c54d1igwhfs3hmphqn", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946923566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969679259}, [junit4] 2> "ignored":true} [junit4] 2> 1013767 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013787 WARN (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:25.566Z. Now: 2018-03-13T19:34:40.294Z [junit4] 2> 1013787 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f804ffeT74q2rv8c54d1igwhfs3hmphqp", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946925566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969680294}, [junit4] 2> "ignored":true} [junit4] 2> 1013787 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013809 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013825 WARN (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:27.566Z. Now: 2018-03-13T19:34:42.233Z [junit4] 2> 1013826 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f8057ceT74q2rv8c54d1igwhfs3hmphqr", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946927566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969682233}, [junit4] 2> "ignored":true} [junit4] 2> 1013833 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013847 WARN (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:29.566Z. Now: 2018-03-13T19:34:43.300Z [junit4] 2> 1013847 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f805f9eT74q2rv8c54d1igwhfs3hmphqt", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946929566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969683300}, [junit4] 2> "ignored":true} [junit4] 2> 1013853 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013868 WARN (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:31.566Z. Now: 2018-03-13T19:34:44.346Z [junit4] 2> 1013868 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f80676eT74q2rv8c54d1igwhfs3hmphqv", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946931566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969684346}, [junit4] 2> "ignored":true} [junit4] 2> 1013874 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013888 WARN (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:33.566Z. Now: 2018-03-13T19:34:45.388Z [junit4] 2> 1013889 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f806f3eT74q2rv8c54d1igwhfs3hmphqx", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946933566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969685388}, [junit4] 2> "ignored":true} [junit4] 2> 1013894 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013909 WARN (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:35.566Z. Now: 2018-03-13T19:34:46.430Z [junit4] 2> 1013909 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f80770eT74q2rv8c54d1igwhfs3hmphqz", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946935566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969686430}, [junit4] 2> "ignored":true} [junit4] 2> 1013914 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013930 WARN (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:37.566Z. Now: 2018-03-13T19:34:47.473Z [junit4] 2> 1013930 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f807edeT74q2rv8c54d1igwhfs3hmphr1", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946937566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969687473}, [junit4] 2> "ignored":true} [junit4] 2> 1013934 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013951 WARN (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:39.566Z. Now: 2018-03-13T19:34:48.512Z [junit4] 2> 1013951 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f8086aeT74q2rv8c54d1igwhfs3hmphr3", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946939566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969688512}, [junit4] 2> "ignored":true} [junit4] 2> 1013955 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013972 WARN (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:41.566Z. Now: 2018-03-13T19:34:49.544Z [junit4] 2> 1013972 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f808e7eT74q2rv8c54d1igwhfs3hmphr5", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946941566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969689544}, [junit4] 2> "ignored":true} [junit4] 2> 1013975 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1013992 WARN (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:43.566Z. Now: 2018-03-13T19:34:50.587Z [junit4] 2> 1013993 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f80964eT74q2rv8c54d1igwhfs3hmphr7", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946943566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969690587}, [junit4] 2> "ignored":true} [junit4] 2> 1013995 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014013 WARN (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:45.566Z. Now: 2018-03-13T19:34:51.623Z [junit4] 2> 1014013 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f809e1eT74q2rv8c54d1igwhfs3hmphr9", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946945566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969691623}, [junit4] 2> "ignored":true} [junit4] 2> 1014015 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014034 WARN (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:47.566Z. Now: 2018-03-13T19:34:52.660Z [junit4] 2> 1014034 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f80a5eeT74q2rv8c54d1igwhfs3hmphrb", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946947566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969692660}, [junit4] 2> "ignored":true} [junit4] 2> 1014035 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014056 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014062 WARN (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:49.566Z. Now: 2018-03-13T19:34:54.066Z [junit4] 2> 1014062 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f80adbeT74q2rv8c54d1igwhfs3hmphrd", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946949566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969694066}, [junit4] 2> "ignored":true} [junit4] 2> 1014076 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014083 WARN (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:51.566Z. Now: 2018-03-13T19:34:55.115Z [junit4] 2> 1014083 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f80b58eT74q2rv8c54d1igwhfs3hmphrf", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946951566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969695115}, [junit4] 2> "ignored":true} [junit4] 2> 1014096 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014104 WARN (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:53.566Z. Now: 2018-03-13T19:34:56.156Z [junit4] 2> 1014104 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f80bd5eT74q2rv8c54d1igwhfs3hmphrh", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946953566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969696156}, [junit4] 2> "ignored":true} [junit4] 2> 1014108 DEBUG (ScheduledTrigger-5598-thread-3) [n:127.0.0.1:36553_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014116 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014126 WARN (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:55.566Z. Now: 2018-03-13T19:34:57.248Z [junit4] 2> 1014126 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f80c52eT74q2rv8c54d1igwhfs3hmphrj", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946955566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969697248}, [junit4] 2> "ignored":true} [junit4] 2> 1014137 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014146 WARN (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:57.566Z. Now: 2018-03-13T19:34:58.289Z [junit4] 2> 1014147 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f80ccfeT74q2rv8c54d1igwhfs3hmphrl", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946957566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969698289}, [junit4] 2> "ignored":true} [junit4] 2> 1014157 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014170 WARN (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:15:59.566Z. Now: 2018-03-13T19:34:59.451Z [junit4] 2> 1014170 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f80d4ceT74q2rv8c54d1igwhfs3hmphrn", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946959566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969699451}, [junit4] 2> "ignored":true} [junit4] 2> 1014177 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014191 WARN (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:16:01.566Z. Now: 2018-03-13T19:35:00.494Z [junit4] 2> 1014191 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f80dc9eT74q2rv8c54d1igwhfs3hmphrp", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946961566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969700494}, [junit4] 2> "ignored":true} [junit4] 2> 1014197 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014211 WARN (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:16:03.566Z. Now: 2018-03-13T19:35:01.532Z [junit4] 2> 1014212 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f80e46eT74q2rv8c54d1igwhfs3hmphrr", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946963566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969701532}, [junit4] 2> "ignored":true} [junit4] 2> 1014218 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014232 WARN (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:16:05.566Z. Now: 2018-03-13T19:35:02.576Z [junit4] 2> 1014232 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f80ec3eT74q2rv8c54d1igwhfs3hmphrt", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946965566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969702576}, [junit4] 2> "ignored":true} [junit4] 2> 1014238 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014253 WARN (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:16:07.566Z. Now: 2018-03-13T19:35:03.614Z [junit4] 2> 1014253 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f80f40eT74q2rv8c54d1igwhfs3hmphrv", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946967566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969703614}, [junit4] 2> "ignored":true} [junit4] 2> 1014258 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014274 WARN (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:16:09.566Z. Now: 2018-03-13T19:35:04.655Z [junit4] 2> 1014274 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f80fbdeT74q2rv8c54d1igwhfs3hmphrx", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946969566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969704655}, [junit4] 2> "ignored":true} [junit4] 2> 1014278 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014295 WARN (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:16:11.566Z. Now: 2018-03-13T19:35:05.699Z [junit4] 2> 1014295 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f8103aeT74q2rv8c54d1igwhfs3hmphrz", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946971566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969705699}, [junit4] 2> "ignored":true} [junit4] 2> 1014298 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014315 WARN (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:16:13.566Z. Now: 2018-03-13T19:35:06.742Z [junit4] 2> 1014316 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f810b7eT74q2rv8c54d1igwhfs3hmphs1", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946973566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969706742}, [junit4] 2> "ignored":true} [junit4] 2> 1014319 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014336 WARN (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:16:15.566Z. Now: 2018-03-13T19:35:07.783Z [junit4] 2> 1014336 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f81134eT74q2rv8c54d1igwhfs3hmphs3", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946975566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969707783}, [junit4] 2> "ignored":true} [junit4] 2> 1014339 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014357 WARN (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:16:17.566Z. Now: 2018-03-13T19:35:08.819Z [junit4] 2> 1014357 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f811b1eT74q2rv8c54d1igwhfs3hmphs5", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946977566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969708819}, [junit4] 2> "ignored":true} [junit4] 2> 1014359 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014378 WARN (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:16:19.566Z. Now: 2018-03-13T19:35:09.857Z [junit4] 2> 1014378 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f8122eeT74q2rv8c54d1igwhfs3hmphs7", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946979566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969709857}, [junit4] 2> "ignored":true} [junit4] 2> 1014379 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014399 WARN (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:16:21.566Z. Now: 2018-03-13T19:35:10.896Z [junit4] 2> 1014399 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f812abeT74q2rv8c54d1igwhfs3hmphs9", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946981566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969710896}, [junit4] 2> "ignored":true} [junit4] 2> 1014399 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014419 WARN (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:16:23.566Z. Now: 2018-03-13T19:35:11.941Z [junit4] 2> 1014420 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f81328eT74q2rv8c54d1igwhfs3hmphsb", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946983566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969711941}, [junit4] 2> "ignored":true} [junit4] 2> 1014420 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014440 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014440 WARN (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:16:25.566Z. Now: 2018-03-13T19:35:12.982Z [junit4] 2> 1014440 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f813a5eT74q2rv8c54d1igwhfs3hmphsd", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946985566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969712982}, [junit4] 2> "ignored":true} [junit4] 2> 1014460 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014462 WARN (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:16:27.566Z. Now: 2018-03-13T19:35:14.046Z [junit4] 2> 1014462 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f81422eT74q2rv8c54d1igwhfs3hmphsf", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946987566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969714046}, [junit4] 2> "ignored":true} [junit4] 2> 1014481 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014486 WARN (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:16:29.566Z. Now: 2018-03-13T19:35:15.248Z [junit4] 2> 1014486 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f8149feT74q2rv8c54d1igwhfs3hmphsh", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946989566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969715248}, [junit4] 2> "ignored":true} [junit4] 2> 1014501 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014521 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014521 WARN (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:16:31.566Z. Now: 2018-03-13T19:35:17.040Z [junit4] 2> 1014522 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f8151ceT74q2rv8c54d1igwhfs3hmphsj", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946991566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969717040}, [junit4] 2> "ignored":true} [junit4] 2> 1014541 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014549 WARN (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:16:33.566Z. Now: 2018-03-13T19:35:18.417Z [junit4] 2> 1014549 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f81599eT74q2rv8c54d1igwhfs3hmphsl", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946993566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969718417}, [junit4] 2> "ignored":true} [junit4] 2> 1014561 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014572 WARN (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:16:35.566Z. Now: 2018-03-13T19:35:19.562Z [junit4] 2> 1014572 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f81616eT74q2rv8c54d1igwhfs3hmphsn", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946995566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969719562}, [junit4] 2> "ignored":true} [junit4] 2> 1014582 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014598 WARN (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:16:37.566Z. Now: 2018-03-13T19:35:20.847Z [junit4] 2> 1014598 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f81693eT74q2rv8c54d1igwhfs3hmphsp", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946997566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969720847}, [junit4] 2> "ignored":true} [junit4] 2> 1014602 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014622 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014626 WARN (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:16:39.566Z. Now: 2018-03-13T19:35:22.248Z [junit4] 2> 1014626 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f81710eT74q2rv8c54d1igwhfs3hmphsr", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520946999566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969722248}, [junit4] 2> "ignored":true} [junit4] 2> 1014642 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014646 WARN (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:16:41.566Z. Now: 2018-03-13T19:35:23.289Z [junit4] 2> 1014647 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f8178deT74q2rv8c54d1igwhfs3hmphst", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520947001566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969723289}, [junit4] 2> "ignored":true} [junit4] 2> 1014663 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014667 WARN (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:16:43.566Z. Now: 2018-03-13T19:35:24.328Z [junit4] 2> 1014667 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f8180aeT74q2rv8c54d1igwhfs3hmphsv", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520947003566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969724328}, [junit4] 2> "ignored":true} [junit4] 2> 1014683 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014688 WARN (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:16:45.566Z. Now: 2018-03-13T19:35:25.366Z [junit4] 2> 1014688 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f81887eT74q2rv8c54d1igwhfs3hmphsx", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520947005566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969725366}, [junit4] 2> "ignored":true} [junit4] 2> 1014703 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014709 WARN (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:16:47.566Z. Now: 2018-03-13T19:35:26.406Z [junit4] 2> 1014709 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f81904eT74q2rv8c54d1igwhfs3hmphsz", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520947007566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969726406}, [junit4] 2> "ignored":true} [junit4] 2> 1014723 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014730 WARN (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:16:49.566Z. Now: 2018-03-13T19:35:27.447Z [junit4] 2> 1014730 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f81981eT74q2rv8c54d1igwhfs3hmpht1", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520947009566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969727447}, [junit4] 2> "ignored":true} [junit4] 2> 1014743 DEBUG (ScheduledTrigger-5605-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014750 WARN (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:16:51.566Z. Now: 2018-03-13T19:35:28.488Z [junit4] 2> 1014751 DEBUG (ScheduledTrigger-5605-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f819feeT74q2rv8c54d1igwhfs3hmpht3", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520947011566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969728488}, [junit4] 2> "ignored":true} [junit4] 2> 1014764 DEBUG (ScheduledTrigger-5605-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1014771 WARN (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-13T13:16:53.566Z. Now: 2018-03-13T19:35:29.530Z [junit4] 2> 1014771 DEBUG (ScheduledTrigger-5605-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"1621f81a7beT74q2rv8c54d1igwhfs3hmpht5", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520947013566, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520969729530}, [junit4] 2> "ignored": [...truncated too long message...] DD0720BBA1]: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> 7972 WARN (AutoscalingActionExecutor-29-thread-1) [ ] o.a.s.c.a.ScheduledTriggers Exception executing actions [junit4] 2> org.apache.lucene.store.AlreadyClosedException: ScheduledTrigger .scheduled_maintenance has been closed. [junit4] 2> at org.apache.solr.cloud.autoscaling.ScheduledTriggers$TriggerWrapper.dequeue(ScheduledTriggers.java: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:1135) [junit4] 2> at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) [junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> 7974 DEBUG (AutoscalingActionExecutor-29-thread-1) [ ] o.a.s.c.a.ScheduledTriggers Resuming trigger: .auto_add_replicas after 100ms [junit4] 2> 7974 DEBUG (AutoscalingActionExecutor-29-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -- processing took 160 ms for event id=3dbfc04492d69T74q2rv8c54d1igwhfs3hmpeww [junit4] 2> 7977 WARN (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting. [junit4] 2> 7977 DEBUG (SUITE-ScheduledMaintenanceTriggerTest-seed#[E51364AF66639CAA]-worker) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly [junit4] 2> 7982 INFO (jetty-closer-25-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@15ab7cb4{SSL,[ssl, http/1.1]}{127.0.0.1:0} [junit4] 2> 7982 INFO (jetty-closer-25-thread-1) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=196924606 [junit4] 2> 7982 INFO (jetty-closer-25-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 7983 INFO (jetty-closer-25-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@623b7c9: rootName = solr_39537, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@6e873f65 [junit4] 2> 7993 INFO (jetty-closer-25-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 7993 INFO (jetty-closer-25-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@131a860e: rootName = solr_39537, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@44779dd2 [junit4] 2> 8001 INFO (jetty-closer-25-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 8001 INFO (jetty-closer-25-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4ecdec77: rootName = solr_39537, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@13e2122d [junit4] 2> 8002 INFO (jetty-closer-25-thread-1) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:39537_solr [junit4] 2> 8003 INFO (jetty-closer-25-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 8003 INFO (zkCallback-39-thread-1-processing-n:127.0.0.1:39537_solr) [n:127.0.0.1:39537_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0) [junit4] 2> 8003 INFO (zkCallback-34-thread-1-processing-n:127.0.0.1:39537_solr) [n:127.0.0.1:39537_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0) [junit4] 2> 8003 INFO (jetty-closer-25-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 8004 INFO (jetty-closer-25-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72128774695550979-127.0.0.1:39537_solr-n_0000000000) closing [junit4] 2> 8004 INFO (OverseerStateUpdate-72128774695550979-127.0.0.1:39537_solr-n_0000000000) [n:127.0.0.1:39537_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:39537_solr [junit4] 2> 8004 WARN (OverseerAutoScalingTriggerThread-72128774695550979-127.0.0.1:39537_solr-n_0000000000) [n:127.0.0.1:39537_solr ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting. [junit4] 2> 8004 DEBUG (jetty-closer-25-thread-1) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly [junit4] 2> 8006 INFO (jetty-closer-25-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5516077b{/solr,null,UNAVAILABLE} [junit4] 2> 8006 INFO (jetty-closer-25-thread-1) [ ] o.e.j.s.session Stopped scavenging [junit4] 2> 8006 ERROR (SUITE-ScheduledMaintenanceTriggerTest-seed#[E51364AF66639CAA]-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> 8007 INFO (SUITE-ScheduledMaintenanceTriggerTest-seed#[E51364AF66639CAA]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:37651 37651 [junit4] 2> 9635 INFO (Thread-11) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:37651 37651 [junit4] 2> 9635 WARN (Thread-11) [ ] o.a.s.c.ZkTestServer Watch limit violations: [junit4] 2> Maximum concurrent create/delete watches above limit: [junit4] 2> [junit4] 2> 3 /solr/aliases.json [junit4] 2> [junit4] 2> Maximum concurrent data watches above limit: [junit4] 2> [junit4] 2> 3 /solr/clusterstate.json [junit4] 2> 3 /solr/clusterprops.json [junit4] 2> [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2> [junit4] 2> 3 /solr/live_nodes [junit4] 2> 3 /solr/collections [junit4] 2> [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest_E51364AF66639CAA-001 [junit4] 2> NOTE: test params are: codec=FastCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST, chunkSize=5792, maxDocsPerChunk=3, blockSize=3), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST, chunkSize=5792, blockSize=3)), sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@4c53f5c7), locale=kam-KE, timezone=America/Kralendijk [junit4] 2> NOTE: Linux 4.13.0-36-generic amd64/Oracle Corporation 10 (64-bit)/cpus=8,threads=1,free=353638392,total=536870912 [junit4] 2> NOTE: All tests run in this JVM: [ScheduledMaintenanceTriggerTest, ScheduledMaintenanceTriggerTest] [junit4] Completed [5/5 (2!)] on J1 in 2.22s, 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: E51364AF66639CAA] Total time: 13 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=cc3c4b61237619798a006217223fb6e78a688a4e, workspace=/var/lib/jenkins/workspace/Lucene-Solr-master-Linux [WARNINGS] Computing warning deltas based on reference build #21632 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