Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/21618/ Java: 32bit/jdk1.8.0_162 -server -XX:+UseSerialGC
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([848FFD53EE04915F:99A33D218F47B654]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest.testInactiveShardCleanup(ScheduledMaintenanceTriggerTest.java:218) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.lang.Thread.run(Thread.java:748) 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([848FFD53EE04915F:99A33D218F47B654]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest.testInactiveShardCleanup(ScheduledMaintenanceTriggerTest.java:218) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.lang.Thread.run(Thread.java:748) 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([848FFD53EE04915F:99A33D218F47B654]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest.testInactiveShardCleanup(ScheduledMaintenanceTriggerTest.java:197) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.lang.Thread.run(Thread.java:748) Build Log: [...truncated 13056 lines...] [junit4] Suite: org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest [junit4] 2> 750016 INFO (SUITE-ScheduledMaintenanceTriggerTest-seed#[848FFD53EE04915F]-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_848FFD53EE04915F-001/init-core-data-001 [junit4] 2> 750016 WARN (SUITE-ScheduledMaintenanceTriggerTest-seed#[848FFD53EE04915F]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1 [junit4] 2> 750016 INFO (SUITE-ScheduledMaintenanceTriggerTest-seed#[848FFD53EE04915F]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true [junit4] 2> 750017 INFO (SUITE-ScheduledMaintenanceTriggerTest-seed#[848FFD53EE04915F]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN) [junit4] 2> 750018 INFO (SUITE-ScheduledMaintenanceTriggerTest-seed#[848FFD53EE04915F]-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_848FFD53EE04915F-001/tempDir-001 [junit4] 2> 750018 INFO (SUITE-ScheduledMaintenanceTriggerTest-seed#[848FFD53EE04915F]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 750018 INFO (Thread-1907) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 750018 INFO (Thread-1907) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 750019 ERROR (Thread-1907) [ ] 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> 750118 INFO (SUITE-ScheduledMaintenanceTriggerTest-seed#[848FFD53EE04915F]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:36177 [junit4] 2> 750120 INFO (zkConnectionManagerCallback-6008-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 750122 INFO (jetty-launcher-6005-thread-1) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T00:27:37+03:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 750138 INFO (jetty-launcher-6005-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 750138 INFO (jetty-launcher-6005-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 750138 INFO (jetty-launcher-6005-thread-1) [ ] o.e.j.s.session Scavenging every 600000ms [junit4] 2> 750138 INFO (jetty-launcher-6005-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5ebbfd{/solr,null,AVAILABLE} [junit4] 2> 750139 INFO (jetty-launcher-6005-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1b2bd9e{SSL,[ssl, http/1.1]}{127.0.0.1:33349} [junit4] 2> 750139 INFO (jetty-launcher-6005-thread-1) [ ] o.e.j.s.Server Started @751477ms [junit4] 2> 750139 INFO (jetty-launcher-6005-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=33349} [junit4] 2> 750139 ERROR (jetty-launcher-6005-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 750139 INFO (jetty-launcher-6005-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.0.0 [junit4] 2> 750139 INFO (jetty-launcher-6005-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 750139 INFO (jetty-launcher-6005-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 750139 INFO (jetty-launcher-6005-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-11T15:12:48.814Z [junit4] 2> 750162 INFO (zkConnectionManagerCallback-6010-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 750163 INFO (jetty-launcher-6005-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 750172 INFO (jetty-launcher-6005-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36177/solr [junit4] 2> 750185 INFO (zkConnectionManagerCallback-6014-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 750187 INFO (zkConnectionManagerCallback-6016-thread-1-processing-n:127.0.0.1:33349_solr) [n:127.0.0.1:33349_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 750214 INFO (jetty-launcher-6005-thread-1) [n:127.0.0.1:33349_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 750214 INFO (jetty-launcher-6005-thread-1) [n:127.0.0.1:33349_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:33349_solr [junit4] 2> 750215 INFO (jetty-launcher-6005-thread-1) [n:127.0.0.1:33349_solr ] o.a.s.c.Overseer Overseer (id=72117806927970307-127.0.0.1:33349_solr-n_0000000000) starting [junit4] 2> 750217 INFO (zkConnectionManagerCallback-6021-thread-1-processing-n:127.0.0.1:33349_solr) [n:127.0.0.1:33349_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 750218 INFO (jetty-launcher-6005-thread-1) [n:127.0.0.1:33349_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:36177/solr ready [junit4] 2> 750218 DEBUG (OverseerAutoScalingTriggerThread-72117806927970307-127.0.0.1:33349_solr-n_0000000000) [n:127.0.0.1:33349_solr ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and .scheduled_maintenance triggers [junit4] 2> 750219 INFO (jetty-launcher-6005-thread-1) [n:127.0.0.1:33349_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33349_solr [junit4] 2> 750219 DEBUG (OverseerAutoScalingTriggerThread-72117806927970307-127.0.0.1:33349_solr-n_0000000000) [n:127.0.0.1:33349_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1 [junit4] 2> 750219 INFO (zkCallback-6020-thread-1-processing-n:127.0.0.1:33349_solr) [n:127.0.0.1:33349_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 750219 INFO (zkCallback-6015-thread-1-processing-n:127.0.0.1:33349_solr) [n:127.0.0.1:33349_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 750219 DEBUG (OverseerAutoScalingTriggerThread-72117806927970307-127.0.0.1:33349_solr-n_0000000000) [n:127.0.0.1:33349_solr ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:33349_solr] [junit4] 2> 750219 DEBUG (OverseerAutoScalingTriggerThread-72117806927970307-127.0.0.1:33349_solr-n_0000000000) [n:127.0.0.1:33349_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion -1 [junit4] 2> 750219 DEBUG (OverseerAutoScalingTriggerThread-72117806927970307-127.0.0.1:33349_solr-n_0000000000) [n:127.0.0.1:33349_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1 [junit4] 2> 750221 DEBUG (OverseerAutoScalingTriggerThread-72117806927970307-127.0.0.1:33349_solr-n_0000000000) [n:127.0.0.1:33349_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers [junit4] 2> 750221 DEBUG (OverseerAutoScalingTriggerThread-72117806927970307-127.0.0.1:33349_solr-n_0000000000) [n:127.0.0.1:33349_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1 [junit4] 2> 750221 DEBUG (ScheduledTrigger-3732-thread-1) [n:127.0.0.1:33349_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750288 INFO (jetty-launcher-6005-thread-1) [n:127.0.0.1:33349_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33349.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1709d6f [junit4] 2> 750293 INFO (jetty-launcher-6005-thread-1) [n:127.0.0.1:33349_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33349.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1709d6f [junit4] 2> 750294 INFO (jetty-launcher-6005-thread-1) [n:127.0.0.1:33349_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33349.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1709d6f [junit4] 2> 750295 INFO (jetty-launcher-6005-thread-1) [n:127.0.0.1:33349_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_848FFD53EE04915F-001/tempDir-001/node1/. [junit4] 2> 750306 INFO (zkConnectionManagerCallback-6023-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 750309 INFO (zkConnectionManagerCallback-6027-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 750310 INFO (SUITE-ScheduledMaintenanceTriggerTest-seed#[848FFD53EE04915F]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 750310 INFO (SUITE-ScheduledMaintenanceTriggerTest-seed#[848FFD53EE04915F]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:36177/solr ready [junit4] 2> 750314 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and .scheduled_maintenance triggers [junit4] 2> 750314 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 0 [junit4] 2> 750314 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10003_solr] [junit4] 2> 750314 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion -1 [junit4] 2> 750314 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 0 [junit4] 2> 750322 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers [junit4] 2> 750329 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion 0 [junit4] 2> 750330 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750335 INFO (TEST-ScheduledMaintenanceTriggerTest.testTriggerDefaults-seed#[848FFD53EE04915F]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testTriggerDefaults [junit4] 2> 750335 INFO (TEST-ScheduledMaintenanceTriggerTest.testTriggerDefaults-seed#[848FFD53EE04915F]) [ ] 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> 750336 DEBUG (simCloudManagerPool-3738-thread-1) [ ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration [junit4] 2> 750336 DEBUG (simCloudManagerPool-3738-thread-1) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1 [junit4] 2> 750336 DEBUG (simCloudManagerPool-3738-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10003_solr] [junit4] 2> 750336 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1 [junit4] 2> 750337 INFO (TEST-ScheduledMaintenanceTriggerTest.testTriggerDefaults-seed#[848FFD53EE04915F]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testTriggerDefaults [junit4] 2> 750337 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers [junit4] 2> 750337 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1 [junit4] 2> 750343 INFO (TEST-ScheduledMaintenanceTriggerTest.testInactiveShardCleanup-seed#[848FFD53EE04915F]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testInactiveShardCleanup [junit4] 2> 750350 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750371 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750391 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750411 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750431 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750451 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750471 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750488 DEBUG (simCloudManagerPool-3738-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:10003_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> 750489 DEBUG (simCloudManagerPool-3738-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:10003_solr", [junit4] 2> "base_url":"http://127.0.0.1:10003/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> 750489 DEBUG (simCloudManagerPool-3738-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:10003_solr", [junit4] 2> "base_url":"http://127.0.0.1:10003/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> 750492 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750493 DEBUG (simCloudManagerPool-3738-thread-8) [ ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration [junit4] 2> 750493 DEBUG (simCloudManagerPool-3738-thread-8) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 2 [junit4] 2> 750493 DEBUG (simCloudManagerPool-3738-thread-8) [ ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10003_solr] [junit4] 2> 750493 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2 [junit4] 2> 750494 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers [junit4] 2> 750494 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2 [junit4] 2> 750494 DEBUG (simCloudManagerPool-3738-thread-9) [ ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration [junit4] 2> 750495 DEBUG (simCloudManagerPool-3738-thread-9) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 3 [junit4] 2> 750495 DEBUG (simCloudManagerPool-3738-thread-9) [ ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10003_solr] [junit4] 2> 750495 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 3 [junit4] 2> 750495 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers [junit4] 2> 750495 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3, lastZnodeVersion 3 [junit4] 2> 750495 WARN (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:12:50.989Z. Now: 2018-03-11T22:46:06.983Z [junit4] 2> 750496 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159f192dTb3h5wtmur7qwcqxgaw08u9fta", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781170989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808366983}, [junit4] 2> "ignored":true} [junit4] 2> 750512 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750517 WARN (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:12:52.989Z. Now: 2018-03-11T22:46:08.050Z [junit4] 2> 750517 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159f20fdTb3h5wtmur7qwcqxgaw08u9ftc", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781172989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808368050}, [junit4] 2> "ignored":true} [junit4] 2> 750532 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750537 WARN (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:12:54.989Z. Now: 2018-03-11T22:46:09.081Z [junit4] 2> 750537 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159f28cdTb3h5wtmur7qwcqxgaw08u9fte", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781174989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808369081}, [junit4] 2> "ignored":true} [junit4] 2> 750552 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750558 WARN (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:12:56.989Z. Now: 2018-03-11T22:46:10.110Z [junit4] 2> 750558 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159f309dTb3h5wtmur7qwcqxgaw08u9ftg", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781176989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808370110}, [junit4] 2> "ignored":true} [junit4] 2> 750572 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750587 WARN (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:12:58.989Z. Now: 2018-03-11T22:46:11.546Z [junit4] 2> 750587 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159f386dTb3h5wtmur7qwcqxgaw08u9fti", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781178989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808371546}, [junit4] 2> "ignored":true} [junit4] 2> 750593 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750607 WARN (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:00.989Z. Now: 2018-03-11T22:46:12.582Z [junit4] 2> 750607 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159f403dTb3h5wtmur7qwcqxgaw08u9ftk", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781180989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808372582}, [junit4] 2> "ignored":true} [junit4] 2> 750613 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750628 WARN (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:02.989Z. Now: 2018-03-11T22:46:13.611Z [junit4] 2> 750628 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159f480dTb3h5wtmur7qwcqxgaw08u9ftm", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781182989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808373611}, [junit4] 2> "ignored":true} [junit4] 2> 750633 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750648 WARN (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:04.989Z. Now: 2018-03-11T22:46:14.640Z [junit4] 2> 750649 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159f4fddTb3h5wtmur7qwcqxgaw08u9fto", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781184989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808374640}, [junit4] 2> "ignored":true} [junit4] 2> 750653 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750669 WARN (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:06.989Z. Now: 2018-03-11T22:46:15.671Z [junit4] 2> 750669 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159f57adTb3h5wtmur7qwcqxgaw08u9ftq", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781186989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808375671}, [junit4] 2> "ignored":true} [junit4] 2> 750673 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750690 WARN (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:08.989Z. Now: 2018-03-11T22:46:16.698Z [junit4] 2> 750690 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159f5f7dTb3h5wtmur7qwcqxgaw08u9fts", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781188989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808376698}, [junit4] 2> "ignored":true} [junit4] 2> 750694 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750710 WARN (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:10.989Z. Now: 2018-03-11T22:46:17.727Z [junit4] 2> 750710 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159f674dTb3h5wtmur7qwcqxgaw08u9ftu", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781190989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808377727}, [junit4] 2> "ignored":true} [junit4] 2> 750714 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750731 WARN (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:12.989Z. Now: 2018-03-11T22:46:18.755Z [junit4] 2> 750731 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159f6f1dTb3h5wtmur7qwcqxgaw08u9ftw", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781192989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808378755}, [junit4] 2> "ignored":true} [junit4] 2> 750734 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750751 WARN (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:14.989Z. Now: 2018-03-11T22:46:19.783Z [junit4] 2> 750751 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159f76edTb3h5wtmur7qwcqxgaw08u9fty", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781194989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808379783}, [junit4] 2> "ignored":true} [junit4] 2> 750754 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750772 WARN (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:16.989Z. Now: 2018-03-11T22:46:20.817Z [junit4] 2> 750772 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159f7ebdTb3h5wtmur7qwcqxgaw08u9fu0", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781196989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808380817}, [junit4] 2> "ignored":true} [junit4] 2> 750774 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750793 WARN (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:18.989Z. Now: 2018-03-11T22:46:21.847Z [junit4] 2> 750793 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159f868dTb3h5wtmur7qwcqxgaw08u9fu2", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781198989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808381847}, [junit4] 2> "ignored":true} [junit4] 2> 750794 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750813 WARN (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:20.989Z. Now: 2018-03-11T22:46:22.873Z [junit4] 2> 750813 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159f8e5dTb3h5wtmur7qwcqxgaw08u9fu4", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781200989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808382873}, [junit4] 2> "ignored":true} [junit4] 2> 750814 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750834 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750834 WARN (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:22.989Z. Now: 2018-03-11T22:46:23.943Z [junit4] 2> 750835 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159f962dTb3h5wtmur7qwcqxgaw08u9fu6", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781202989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808383943}, [junit4] 2> "ignored":true} [junit4] 2> 750855 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750855 WARN (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:24.989Z. Now: 2018-03-11T22:46:24.969Z [junit4] 2> 750855 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159f9dfdTb3h5wtmur7qwcqxgaw08u9fu8", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781204989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808384969}, [junit4] 2> "ignored":true} [junit4] 2> 750875 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750875 WARN (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:26.989Z. Now: 2018-03-11T22:46:25.994Z [junit4] 2> 750876 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159fa5cdTb3h5wtmur7qwcqxgaw08u9fua", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781206989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808385994}, [junit4] 2> "ignored":true} [junit4] 2> 750895 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750896 WARN (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:28.989Z. Now: 2018-03-11T22:46:27.020Z [junit4] 2> 750896 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159fad9dTb3h5wtmur7qwcqxgaw08u9fuc", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781208989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808387020}, [junit4] 2> "ignored":true} [junit4] 2> 750915 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750916 WARN (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:30.989Z. Now: 2018-03-11T22:46:28.045Z [junit4] 2> 750917 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159fb56dTb3h5wtmur7qwcqxgaw08u9fue", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781210989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808388045}, [junit4] 2> "ignored":true} [junit4] 2> 750935 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750937 WARN (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:32.989Z. Now: 2018-03-11T22:46:29.069Z [junit4] 2> 750937 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159fbd3dTb3h5wtmur7qwcqxgaw08u9fug", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781212989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808389069}, [junit4] 2> "ignored":true} [junit4] 2> 750955 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750957 WARN (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:34.989Z. Now: 2018-03-11T22:46:30.093Z [junit4] 2> 750958 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159fc50dTb3h5wtmur7qwcqxgaw08u9fui", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781214989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808390093}, [junit4] 2> "ignored":true} [junit4] 2> 750976 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750978 WARN (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:36.989Z. Now: 2018-03-11T22:46:31.126Z [junit4] 2> 750978 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159fccddTb3h5wtmur7qwcqxgaw08u9fuk", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781216989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808391126}, [junit4] 2> "ignored":true} [junit4] 2> 750996 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 750999 WARN (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:38.989Z. Now: 2018-03-11T22:46:32.164Z [junit4] 2> 750999 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159fd4adTb3h5wtmur7qwcqxgaw08u9fum", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781218989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808392164}, [junit4] 2> "ignored":true} [junit4] 2> 751016 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751019 WARN (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:40.989Z. Now: 2018-03-11T22:46:33.192Z [junit4] 2> 751020 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159fdc7dTb3h5wtmur7qwcqxgaw08u9fuo", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781220989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808393192}, [junit4] 2> "ignored":true} [junit4] 2> 751036 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751040 WARN (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:42.989Z. Now: 2018-03-11T22:46:34.221Z [junit4] 2> 751040 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159fe44dTb3h5wtmur7qwcqxgaw08u9fuq", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781222989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808394221}, [junit4] 2> "ignored":true} [junit4] 2> 751056 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751061 WARN (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:44.989Z. Now: 2018-03-11T22:46:35.253Z [junit4] 2> 751061 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159fec1dTb3h5wtmur7qwcqxgaw08u9fus", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781224989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808395253}, [junit4] 2> "ignored":true} [junit4] 2> 751077 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751082 WARN (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:46.989Z. Now: 2018-03-11T22:46:36.297Z [junit4] 2> 751082 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159ff3edTb3h5wtmur7qwcqxgaw08u9fuu", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781226989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808396297}, [junit4] 2> "ignored":true} [junit4] 2> 751097 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751102 WARN (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:48.989Z. Now: 2018-03-11T22:46:37.335Z [junit4] 2> 751102 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"162159ffbbdTb3h5wtmur7qwcqxgaw08u9fuw", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781228989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808397335}, [junit4] 2> "ignored":true} [junit4] 2> 751117 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751123 WARN (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:50.989Z. Now: 2018-03-11T22:46:38.368Z [junit4] 2> 751123 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a0038dTb3h5wtmur7qwcqxgaw08u9fuy", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781230989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808398368}, [junit4] 2> "ignored":true} [junit4] 2> 751137 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751144 WARN (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:52.989Z. Now: 2018-03-11T22:46:39.398Z [junit4] 2> 751144 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a00b5dTb3h5wtmur7qwcqxgaw08u9fv0", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781232989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808399398}, [junit4] 2> "ignored":true} [junit4] 2> 751157 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751164 WARN (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:54.989Z. Now: 2018-03-11T22:46:40.435Z [junit4] 2> 751165 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a0132dTb3h5wtmur7qwcqxgaw08u9fv2", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781234989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808400435}, [junit4] 2> "ignored":true} [junit4] 2> 751178 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751185 WARN (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:56.989Z. Now: 2018-03-11T22:46:41.473Z [junit4] 2> 751185 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a01afdTb3h5wtmur7qwcqxgaw08u9fv4", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781236989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808401473}, [junit4] 2> "ignored":true} [junit4] 2> 751198 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751206 WARN (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:13:58.989Z. Now: 2018-03-11T22:46:42.510Z [junit4] 2> 751206 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a022cdTb3h5wtmur7qwcqxgaw08u9fv6", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781238989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808402510}, [junit4] 2> "ignored":true} [junit4] 2> 751218 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751222 DEBUG (ScheduledTrigger-3732-thread-3) [n:127.0.0.1:33349_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751226 WARN (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:00.989Z. Now: 2018-03-11T22:46:43.545Z [junit4] 2> 751227 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a02a9dTb3h5wtmur7qwcqxgaw08u9fv8", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781240989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808403545}, [junit4] 2> "ignored":true} [junit4] 2> 751238 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751247 WARN (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:02.989Z. Now: 2018-03-11T22:46:44.574Z [junit4] 2> 751247 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a0326dTb3h5wtmur7qwcqxgaw08u9fva", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781242989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808404574}, [junit4] 2> "ignored":true} [junit4] 2> 751258 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751268 WARN (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:04.989Z. Now: 2018-03-11T22:46:45.613Z [junit4] 2> 751268 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a03a3dTb3h5wtmur7qwcqxgaw08u9fvc", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781244989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808405613}, [junit4] 2> "ignored":true} [junit4] 2> 751279 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751289 WARN (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:06.989Z. Now: 2018-03-11T22:46:46.648Z [junit4] 2> 751289 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a0420dTb3h5wtmur7qwcqxgaw08u9fve", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781246989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808406648}, [junit4] 2> "ignored":true} [junit4] 2> 751299 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751309 WARN (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:08.989Z. Now: 2018-03-11T22:46:47.684Z [junit4] 2> 751309 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a049ddTb3h5wtmur7qwcqxgaw08u9fvg", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781248989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808407684}, [junit4] 2> "ignored":true} [junit4] 2> 751319 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751330 WARN (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:10.989Z. Now: 2018-03-11T22:46:48.724Z [junit4] 2> 751330 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a051adTb3h5wtmur7qwcqxgaw08u9fvi", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781250989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808408724}, [junit4] 2> "ignored":true} [junit4] 2> 751339 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751351 WARN (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:12.989Z. Now: 2018-03-11T22:46:49.765Z [junit4] 2> 751351 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a0597dTb3h5wtmur7qwcqxgaw08u9fvk", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781252989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808409765}, [junit4] 2> "ignored":true} [junit4] 2> 751359 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751372 WARN (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:14.989Z. Now: 2018-03-11T22:46:50.801Z [junit4] 2> 751372 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a0614dTb3h5wtmur7qwcqxgaw08u9fvm", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781254989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808410801}, [junit4] 2> "ignored":true} [junit4] 2> 751380 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751392 WARN (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:16.989Z. Now: 2018-03-11T22:46:51.838Z [junit4] 2> 751393 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a0691dTb3h5wtmur7qwcqxgaw08u9fvo", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781256989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808411838}, [junit4] 2> "ignored":true} [junit4] 2> 751400 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751413 WARN (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:18.989Z. Now: 2018-03-11T22:46:52.875Z [junit4] 2> 751413 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a070edTb3h5wtmur7qwcqxgaw08u9fvq", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781258989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808412875}, [junit4] 2> "ignored":true} [junit4] 2> 751420 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751434 WARN (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:20.989Z. Now: 2018-03-11T22:46:53.910Z [junit4] 2> 751434 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a078bdTb3h5wtmur7qwcqxgaw08u9fvs", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781260989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808413910}, [junit4] 2> "ignored":true} [junit4] 2> 751440 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751454 WARN (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:22.989Z. Now: 2018-03-11T22:46:54.934Z [junit4] 2> 751454 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a0808dTb3h5wtmur7qwcqxgaw08u9fvu", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781262989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808414934}, [junit4] 2> "ignored":true} [junit4] 2> 751460 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751475 WARN (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:24.989Z. Now: 2018-03-11T22:46:55.959Z [junit4] 2> 751475 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a0885dTb3h5wtmur7qwcqxgaw08u9fvw", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781264989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808415959}, [junit4] 2> "ignored":true} [junit4] 2> 751481 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751495 WARN (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:26.989Z. Now: 2018-03-11T22:46:56.991Z [junit4] 2> 751496 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a0902dTb3h5wtmur7qwcqxgaw08u9fvy", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781266989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808416991}, [junit4] 2> "ignored":true} [junit4] 2> 751501 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751516 WARN (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:28.989Z. Now: 2018-03-11T22:46:58.024Z [junit4] 2> 751516 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a097fdTb3h5wtmur7qwcqxgaw08u9fw0", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781268989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808418024}, [junit4] 2> "ignored":true} [junit4] 2> 751521 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751537 WARN (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:30.989Z. Now: 2018-03-11T22:46:59.058Z [junit4] 2> 751537 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a09fcdTb3h5wtmur7qwcqxgaw08u9fw2", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781270989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808419058}, [junit4] 2> "ignored":true} [junit4] 2> 751541 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751557 WARN (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:32.989Z. Now: 2018-03-11T22:47:00.087Z [junit4] 2> 751558 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a0a79dTb3h5wtmur7qwcqxgaw08u9fw4", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781272989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808420087}, [junit4] 2> "ignored":true} [junit4] 2> 751561 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751578 WARN (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:34.989Z. Now: 2018-03-11T22:47:01.120Z [junit4] 2> 751578 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a0af6dTb3h5wtmur7qwcqxgaw08u9fw6", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781274989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808421120}, [junit4] 2> "ignored":true} [junit4] 2> 751581 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751599 WARN (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:36.989Z. Now: 2018-03-11T22:47:02.149Z [junit4] 2> 751599 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a0b73dTb3h5wtmur7qwcqxgaw08u9fw8", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781276989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808422149}, [junit4] 2> "ignored":true} [junit4] 2> 751602 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751619 WARN (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:38.989Z. Now: 2018-03-11T22:47:03.183Z [junit4] 2> 751619 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a0bf0dTb3h5wtmur7qwcqxgaw08u9fwa", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781278989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808423183}, [junit4] 2> "ignored":true} [junit4] 2> 751622 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751640 WARN (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:40.989Z. Now: 2018-03-11T22:47:04.210Z [junit4] 2> 751640 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a0c6ddTb3h5wtmur7qwcqxgaw08u9fwc", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781280989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808424210}, [junit4] 2> "ignored":true} [junit4] 2> 751642 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751660 WARN (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:42.989Z. Now: 2018-03-11T22:47:05.242Z [junit4] 2> 751661 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a0ceadTb3h5wtmur7qwcqxgaw08u9fwe", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781282989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808425242}, [junit4] 2> "ignored":true} [junit4] 2> 751662 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751681 WARN (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:44.989Z. Now: 2018-03-11T22:47:06.270Z [junit4] 2> 751681 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a0d67dTb3h5wtmur7qwcqxgaw08u9fwg", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781284989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808426270}, [junit4] 2> "ignored":true} [junit4] 2> 751682 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751702 WARN (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:46.989Z. Now: 2018-03-11T22:47:07.298Z [junit4] 2> 751702 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a0de4dTb3h5wtmur7qwcqxgaw08u9fwi", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781286989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808427298}, [junit4] 2> "ignored":true} [junit4] 2> 751702 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751722 WARN (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:48.989Z. Now: 2018-03-11T22:47:08.323Z [junit4] 2> 751722 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a0e61dTb3h5wtmur7qwcqxgaw08u9fwk", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781288989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808428323}, [junit4] 2> "ignored":true} [junit4] 2> 751722 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751742 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751742 WARN (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:50.989Z. Now: 2018-03-11T22:47:09.344Z [junit4] 2> 751743 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a0ededTb3h5wtmur7qwcqxgaw08u9fwm", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781290989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808429344}, [junit4] 2> "ignored":true} [junit4] 2> 751763 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751763 WARN (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:52.989Z. Now: 2018-03-11T22:47:10.380Z [junit4] 2> 751763 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a0f5bdTb3h5wtmur7qwcqxgaw08u9fwo", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781292989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808430380}, [junit4] 2> "ignored":true} [junit4] 2> 751783 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751784 WARN (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:54.989Z. Now: 2018-03-11T22:47:11.406Z [junit4] 2> 751784 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a0fd8dTb3h5wtmur7qwcqxgaw08u9fwq", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781294989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808431406}, [junit4] 2> "ignored":true} [junit4] 2> 751803 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751804 WARN (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:56.989Z. Now: 2018-03-11T22:47:12.430Z [junit4] 2> 751804 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a1055dTb3h5wtmur7qwcqxgaw08u9fws", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781296989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808432430}, [junit4] 2> "ignored":true} [junit4] 2> 751823 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751825 WARN (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:14:58.989Z. Now: 2018-03-11T22:47:13.448Z [junit4] 2> 751825 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a10d2dTb3h5wtmur7qwcqxgaw08u9fwu", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781298989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808433448}, [junit4] 2> "ignored":true} [junit4] 2> 751843 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751845 WARN (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:15:00.989Z. Now: 2018-03-11T22:47:14.473Z [junit4] 2> 751845 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a114fdTb3h5wtmur7qwcqxgaw08u9fww", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781300989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808434473}, [junit4] 2> "ignored":true} [junit4] 2> 751863 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751866 WARN (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:15:02.989Z. Now: 2018-03-11T22:47:15.500Z [junit4] 2> 751866 DEBUG (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a11ccdTb3h5wtmur7qwcqxgaw08u9fwy", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781302989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808435500}, [junit4] 2> "ignored":true} [junit4] 2> 751884 DEBUG (ScheduledTrigger-3739-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751886 WARN (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:15:04.989Z. Now: 2018-03-11T22:47:16.535Z [junit4] 2> 751887 DEBUG (ScheduledTrigger-3739-thread-2) [ ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: { [junit4] 2> "id":"16215a1249dTb3h5wtmur7qwcqxgaw08u9fx0", [junit4] 2> "source":".scheduled_maintenance", [junit4] 2> "eventTime":1520781304989, [junit4] 2> "eventType":"SCHEDULED", [junit4] 2> "properties":{"actualEventTime":1520808436535}, [junit4] 2> "ignored":true} [junit4] 2> 751904 DEBUG (ScheduledTrigger-3739-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 751907 WARN (ScheduledTrigger-3739-thread-1) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-11T15:15:06.989Z. Now: 201 [...truncated too long message...] AwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> 5199 DEBUG (AutoscalingActionExecutor-29-thread-1) [ ] o.a.s.c.a.ScheduledTriggers Resuming trigger: .auto_add_replicas after 100ms [junit4] 2> 5199 DEBUG (AutoscalingActionExecutor-29-thread-1) [ ] o.a.s.c.a.ScheduledTriggers -- processing took 84 ms for event id=3457f1d1a9562Tb3h5wtmur7qwcqxgaw08u9ay9 [junit4] 2> 5199 DEBUG (simCloudManagerPool-27-thread-12) [ ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10001_solr] [junit4] 2> 5199 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 5 [junit4] 2> 5199 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers [junit4] 2> 5199 DEBUG (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 5, lastZnodeVersion 5 [junit4] 2> 5199 INFO (TEST-ScheduledMaintenanceTriggerTest.testInactiveShardCleanup-seed#[848FFD53EE04915F]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testInactiveShardCleanup [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ScheduledMaintenanceTriggerTest -Dtests.method=testInactiveShardCleanup -Dtests.seed=848FFD53EE04915F -Dtests.multiplier=3 -Dtests.slow=true -Dtests.badapples=true -Dtests.locale=fi-FI -Dtests.timezone=Antarctica/Syowa -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1 [junit4] FAILURE 0.18s J0 | ScheduledMaintenanceTriggerTest.testInactiveShardCleanup <<< [junit4] > Throwable #1: java.lang.AssertionError: should be at least one inactive event [junit4] > at __randomizedtesting.SeedInfo.seed([848FFD53EE04915F:99A33D218F47B654]:0) [junit4] > at org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest.testInactiveShardCleanup(ScheduledMaintenanceTriggerTest.java:218) [junit4] > at java.lang.Thread.run(Thread.java:748) [junit4] 2> 5203 WARN (Simulated OverseerAutoScalingTriggerThread) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting. [junit4] 2> 5203 DEBUG (SUITE-ScheduledMaintenanceTriggerTest-seed#[848FFD53EE04915F]-worker) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly [junit4] 2> 5205 INFO (jetty-closer-25-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@f13bbc{SSL,[ssl, http/1.1]}{127.0.0.1:0} [junit4] 2> 5205 INFO (jetty-closer-25-thread-1) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=14678722 [junit4] 2> 5205 INFO (jetty-closer-25-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 5205 INFO (jetty-closer-25-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@195116d: rootName = solr_45657, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@1014787 [junit4] 2> 5217 INFO (jetty-closer-25-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 5218 INFO (jetty-closer-25-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@d3a878: rootName = solr_45657, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@5c71b5 [junit4] 2> 5224 INFO (jetty-closer-25-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 5224 INFO (jetty-closer-25-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1395449: rootName = solr_45657, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@19f0ad5 [junit4] 2> 5226 INFO (jetty-closer-25-thread-1) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:45657_solr [junit4] 2> 5226 INFO (jetty-closer-25-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 5227 INFO (zkCallback-34-thread-1-processing-n:127.0.0.1:45657_solr) [n:127.0.0.1:45657_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0) [junit4] 2> 5227 INFO (zkCallback-39-thread-1-processing-n:127.0.0.1:45657_solr) [n:127.0.0.1:45657_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0) [junit4] 2> 5227 INFO (jetty-closer-25-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 5227 INFO (jetty-closer-25-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72117934637973507-127.0.0.1:45657_solr-n_0000000000) closing [junit4] 2> 5227 INFO (OverseerStateUpdate-72117934637973507-127.0.0.1:45657_solr-n_0000000000) [n:127.0.0.1:45657_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:45657_solr [junit4] 2> 5227 WARN (OverseerAutoScalingTriggerThread-72117934637973507-127.0.0.1:45657_solr-n_0000000000) [n:127.0.0.1:45657_solr ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting. [junit4] 2> 5228 DEBUG (jetty-closer-25-thread-1) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly [junit4] 2> 5229 INFO (jetty-closer-25-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1bf6490{/solr,null,UNAVAILABLE} [junit4] 2> 5229 INFO (jetty-closer-25-thread-1) [ ] o.e.j.s.session Stopped scavenging [junit4] 2> 5230 ERROR (SUITE-ScheduledMaintenanceTriggerTest-seed#[848FFD53EE04915F]-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> 5230 INFO (SUITE-ScheduledMaintenanceTriggerTest-seed#[848FFD53EE04915F]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:36953 36953 [junit4] 2> 6800 INFO (Thread-12) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:36953 36953 [junit4] 2> 6801 WARN (Thread-12) [ ] 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/J0/temp/solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest_848FFD53EE04915F-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=138, maxMBSortInHeap=7.960857568821769, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@11911b7), locale=fi-FI, timezone=Antarctica/Syowa [junit4] 2> NOTE: Linux 4.13.0-36-generic i386/Oracle Corporation 1.8.0_162 (32-bit)/cpus=8,threads=1,free=39560992,total=65011712 [junit4] 2> NOTE: All tests run in this JVM: [ScheduledMaintenanceTriggerTest, ScheduledMaintenanceTriggerTest] [junit4] Completed [5/5 (2!)] on J0 in 2.33s, 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: 848FFD53EE04915F] Total time: 11 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=8f1350af20c682df7b7fb9e3af762e03b944fdb9, workspace=/var/lib/jenkins/workspace/Lucene-Solr-master-Linux [WARNINGS] Computing warning deltas based on reference build #21617 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