lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@thetaphi.de>
Subject [JENKINS] Lucene-Solr-master-Windows (64bit/jdk1.8.0_144) - Build # 7213 - Still Unstable!
Date Sat, 10 Mar 2018 10:07:28 GMT
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/7213/
Java: 64bit/jdk1.8.0_144 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC

8 tests failed.
FAILED:  junit.framework.TestSuite.org.apache.lucene.index.TestBackwardsCompatibility

Error Message:
Could not remove the following files (in the order of attempts):    C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\backward-codecs\test\J1\temp\lucene.index.TestBackwardsCompatibility_772887C432B19E65-001\2.4.0-cfs-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\backward-codecs\test\J1\temp\lucene.index.TestBackwardsCompatibility_772887C432B19E65-001\2.4.0-cfs-001 

Stack Trace:
java.io.IOException: Could not remove the following files (in the order of attempts):
   C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\backward-codecs\test\J1\temp\lucene.index.TestBackwardsCompatibility_772887C432B19E65-001\2.4.0-cfs-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\backward-codecs\test\J1\temp\lucene.index.TestBackwardsCompatibility_772887C432B19E65-001\2.4.0-cfs-001

	at __randomizedtesting.SeedInfo.seed([772887C432B19E65]:0)
	at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
	at org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:216)
	at com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43)
	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([D52DB2283DB47881:C801725A5CF75F8A]: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:
missing cleanup event

Stack Trace:
java.lang.AssertionError: missing cleanup event
	at __randomizedtesting.SeedInfo.seed([D52DB2283DB47881:C801725A5CF75F8A]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.junit.Assert.assertNotNull(Assert.java:526)
	at org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest.testInactiveShardCleanup(ScheduledMaintenanceTriggerTest.java:219)
	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:
missing cleanup event

Stack Trace:
java.lang.AssertionError: missing cleanup event
	at __randomizedtesting.SeedInfo.seed([D52DB2283DB47881:C801725A5CF75F8A]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.junit.Assert.assertNotNull(Assert.java:526)
	at org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest.testInactiveShardCleanup(ScheduledMaintenanceTriggerTest.java:219)
	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([D52DB2283DB47881:C801725A5CF75F8A]: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)


FAILED:  org.apache.solr.update.processor.TimeRoutedAliasUpdateProcessorTest.test

Error Message:
Expected no errors: [{type=ADD,id=9,message=We need to create a new time routed collection but for unknown reasons were unable to do so.}]

Stack Trace:
java.lang.AssertionError: Expected no errors: [{type=ADD,id=9,message=We need to create a new time routed collection but for unknown reasons were unable to do so.}]
	at __randomizedtesting.SeedInfo.seed([D52DB2283DB47881:5D798DF293481579]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.apache.solr.update.processor.TimeRoutedAliasUpdateProcessorTest.assertUpdateResponse(TimeRoutedAliasUpdateProcessorTest.java:305)
	at org.apache.solr.update.processor.TimeRoutedAliasUpdateProcessorTest.addDocsAndCommit(TimeRoutedAliasUpdateProcessorTest.java:263)
	at org.apache.solr.update.processor.TimeRoutedAliasUpdateProcessorTest.test(TimeRoutedAliasUpdateProcessorTest.java:195)
	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:  junit.framework.TestSuite.org.apache.solr.update.processor.TimeRoutedAliasUpdateProcessorTest

Error Message:
2 threads leaked from SUITE scope at org.apache.solr.update.processor.TimeRoutedAliasUpdateProcessorTest:     1) Thread[id=36476, name=test-14047-thread-1, state=WAITING, group=TGRP-TimeRoutedAliasUpdateProcessorTest]         at sun.misc.Unsafe.park(Native Method)         at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)         at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)         at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)         at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)         at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)         at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)         at java.lang.Thread.run(Thread.java:748)    2) Thread[id=36477, name=test-14047-thread-2, state=WAITING, group=TGRP-TimeRoutedAliasUpdateProcessorTest]         at sun.misc.Unsafe.park(Native Method)         at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)         at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)         at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)         at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)         at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)         at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)         at java.lang.Thread.run(Thread.java:748)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 2 threads leaked from SUITE scope at org.apache.solr.update.processor.TimeRoutedAliasUpdateProcessorTest: 
   1) Thread[id=36476, name=test-14047-thread-1, state=WAITING, group=TGRP-TimeRoutedAliasUpdateProcessorTest]
        at sun.misc.Unsafe.park(Native Method)
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
        at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
        at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
        at java.lang.Thread.run(Thread.java:748)
   2) Thread[id=36477, name=test-14047-thread-2, state=WAITING, group=TGRP-TimeRoutedAliasUpdateProcessorTest]
        at sun.misc.Unsafe.park(Native Method)
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
        at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
        at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
        at java.lang.Thread.run(Thread.java:748)
	at __randomizedtesting.SeedInfo.seed([D52DB2283DB47881]:0)


FAILED:  junit.framework.TestSuite.org.apache.solr.update.processor.TimeRoutedAliasUpdateProcessorTest

Error Message:
There are still zombie threads that couldn't be terminated:    1) Thread[id=36476, name=test-14047-thread-1, state=WAITING, group=TGRP-TimeRoutedAliasUpdateProcessorTest]         at sun.misc.Unsafe.park(Native Method)         at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)         at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)         at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)         at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)         at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)         at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)         at java.lang.Thread.run(Thread.java:748)    2) Thread[id=36477, name=test-14047-thread-2, state=WAITING, group=TGRP-TimeRoutedAliasUpdateProcessorTest]         at sun.misc.Unsafe.park(Native Method)         at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)         at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)         at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)         at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)         at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)         at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)         at java.lang.Thread.run(Thread.java:748)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
   1) Thread[id=36476, name=test-14047-thread-1, state=WAITING, group=TGRP-TimeRoutedAliasUpdateProcessorTest]
        at sun.misc.Unsafe.park(Native Method)
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
        at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
        at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
        at java.lang.Thread.run(Thread.java:748)
   2) Thread[id=36477, name=test-14047-thread-2, state=WAITING, group=TGRP-TimeRoutedAliasUpdateProcessorTest]
        at sun.misc.Unsafe.park(Native Method)
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
        at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
        at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
        at java.lang.Thread.run(Thread.java:748)
	at __randomizedtesting.SeedInfo.seed([D52DB2283DB47881]:0)




Build Log:
[...truncated 4901 lines...]
   [junit4] Suite: org.apache.lucene.index.TestBackwardsCompatibility
   [junit4] IGNOR/A 0.00s J1 | TestBackwardsCompatibility.testCreateCFS
   [junit4]    > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
   [junit4] IGNOR/A 0.00s J1 | TestBackwardsCompatibility.testCreateSortedIndex
   [junit4]    > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
   [junit4] IGNOR/A 0.00s J1 | TestBackwardsCompatibility.testCreateIndexWithDocValuesUpdates
   [junit4]    > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
   [junit4] IGNOR/A 0.00s J1 | TestBackwardsCompatibility.testCreateNoCFS
   [junit4]    > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
   [junit4] IGNOR/A 0.00s J1 | TestBackwardsCompatibility.testCreateMoreTermsIndex
   [junit4]    > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
   [junit4] IGNOR/A 0.00s J1 | TestBackwardsCompatibility.testCreateEmptyIndex
   [junit4]    > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
   [junit4] IGNOR/A 0.00s J1 | TestBackwardsCompatibility.testCreateSingleSegmentNoCFS
   [junit4]    > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
   [junit4] IGNOR/A 0.00s J1 | TestBackwardsCompatibility.testCreateSingleSegmentCFS
   [junit4]    > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {content6=FSTOrd50, content5=PostingsFormat(name=Memory), content4=PostingsFormat(name=MockRandom), content3=PostingsFormat(name=Asserting), content2=FSTOrd50, fie?ld=FSTOrd50, utf8=PostingsFormat(name=MockRandom), id=FSTOrd50, content=PostingsFormat(name=MockRandom), autf8=PostingsFormat(name=Asserting)}, docValues:{ndv2=DocValuesFormat(name=Lucene70), ndv1=DocValuesFormat(name=Direct), utf8=DocValuesFormat(name=Direct), fie?ld=DocValuesFormat(name=Memory), dvShort=DocValuesFormat(name=Lucene70), dvInt=DocValuesFormat(name=Direct), longPoint2d=DocValuesFormat(name=Lucene70), dvBytesSortedVar=DocValuesFormat(name=Memory), dvSortedSet=DocValuesFormat(name=Memory), content=DocValuesFormat(name=Direct), floatPoint1d=DocValuesFormat(name=Memory), bdv2=DocValuesFormat(name=Lucene70), bdv2_c=DocValuesFormat(name=Lucene70), intPoint1d=DocValuesFormat(name=Lucene70), bdv1=DocValuesFormat(name=Direct), bdv1_c=DocValuesFormat(name=Memory), doublePoint2d=DocValuesFormat(name=Memory), dvBytesDerefVar=DocValuesFormat(name=Lucene70), id=DocValuesFormat(name=Memory), binaryPoint2d=DocValuesFormat(name=Direct), dvSortedNumeric=DocValuesFormat(name=Lucene70), dvBytesDerefFixed=DocValuesFormat(name=Direct), autf8=DocValuesFormat(name=Lucene70), dvBytesSortedFixed=DocValuesFormat(name=Lucene70), dvBytesStraightVar=DocValuesFormat(name=Lucene70), dvBytesStraightFixed=DocValuesFormat(name=Memory), dvLong=DocValuesFormat(name=Lucene70), longPoint1d=DocValuesFormat(name=Direct), floatPoint2d=DocValuesFormat(name=Lucene70), dvDouble=DocValuesFormat(name=Memory), dvFloat=DocValuesFormat(name=Lucene70), content6=DocValuesFormat(name=Memory), content5=DocValuesFormat(name=Lucene70), dvPacked=DocValuesFormat(name=Lucene70), intPoint2d=DocValuesFormat(name=Memory), content4=DocValuesFormat(name=Direct), content3=DocValuesFormat(name=Lucene70), content2=DocValuesFormat(name=Memory), doublePoint1d=DocValuesFormat(name=Lucene70), dvByte=DocValuesFormat(name=Lucene70), ndv1_c=DocValuesFormat(name=Memory), ndv2_c=DocValuesFormat(name=Lucene70), binaryPoint1d=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=141, maxMBSortInHeap=6.577283735518945, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@645fff21), locale=sr-ME, timezone=Europe/Simferopol
   [junit4]   2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 1.8.0_144 (64-bit)/cpus=3,threads=1,free=65877776,total=97320960
   [junit4]   2> NOTE: All tests run in this JVM: [TestManyPointsInOldIndex, TestBackwardsCompatibility]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestBackwardsCompatibility -Dtests.seed=772887C432B19E65 -Dtests.slow=true -Dtests.locale=sr-ME -Dtests.timezone=Europe/Simferopol -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.00s J1 | TestBackwardsCompatibility (suite) <<<
   [junit4]    > Throwable #1: java.io.IOException: Could not remove the following files (in the order of attempts):
   [junit4]    >    C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\backward-codecs\test\J1\temp\lucene.index.TestBackwardsCompatibility_772887C432B19E65-001\2.4.0-cfs-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\backward-codecs\test\J1\temp\lucene.index.TestBackwardsCompatibility_772887C432B19E65-001\2.4.0-cfs-001
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([772887C432B19E65]:0)
   [junit4]    > 	at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:748)
   [junit4] Completed [3/3 (1!)] on J1 in 19.20s, 30 tests, 1 error, 8 skipped <<< FAILURES!

[...truncated 8528 lines...]
   [junit4] Suite: org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest
   [junit4]   2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest_D52DB2283DB47881-001\init-core-data-001
   [junit4]   2> 1839945 WARN  (SUITE-ScheduledMaintenanceTriggerTest-seed#[D52DB2283DB47881]-worker) [    ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=67 numCloses=67
   [junit4]   2> 1839945 INFO  (SUITE-ScheduledMaintenanceTriggerTest-seed#[D52DB2283DB47881]-worker) [    ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 1839951 INFO  (SUITE-ScheduledMaintenanceTriggerTest-seed#[D52DB2283DB47881]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
   [junit4]   2> 1839951 INFO  (SUITE-ScheduledMaintenanceTriggerTest-seed#[D52DB2283DB47881]-worker) [    ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 1839954 INFO  (SUITE-ScheduledMaintenanceTriggerTest-seed#[D52DB2283DB47881]-worker) [    ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest_D52DB2283DB47881-001\tempDir-001
   [junit4]   2> 1839955 INFO  (SUITE-ScheduledMaintenanceTriggerTest-seed#[D52DB2283DB47881]-worker) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1839955 INFO  (Thread-3191) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1839955 INFO  (Thread-3191) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 1839959 ERROR (Thread-3191) [    ] 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> 1840055 INFO  (SUITE-ScheduledMaintenanceTriggerTest-seed#[D52DB2283DB47881]-worker) [    ] o.a.s.c.ZkTestServer start zk server on port:54083
   [junit4]   2> 1840060 INFO  (zkConnectionManagerCallback-5388-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1840062 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x1002e2d9ea30000, likely client has closed socket
   [junit4]   2> 1840065 INFO  (jetty-launcher-5385-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> 1840065 INFO  (jetty-launcher-5385-thread-1) [    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1840066 INFO  (jetty-launcher-5385-thread-1) [    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1840066 INFO  (jetty-launcher-5385-thread-1) [    ] o.e.j.s.session Scavenging every 660000ms
   [junit4]   2> 1840066 INFO  (jetty-launcher-5385-thread-1) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@61d7ff20{/solr,null,AVAILABLE}
   [junit4]   2> 1840076 INFO  (jetty-launcher-5385-thread-1) [    ] o.e.j.s.AbstractConnector Started ServerConnector@94134c6{HTTP/1.1,[http/1.1]}{127.0.0.1:54087}
   [junit4]   2> 1840076 INFO  (jetty-launcher-5385-thread-1) [    ] o.e.j.s.Server Started @1847997ms
   [junit4]   2> 1840076 INFO  (jetty-launcher-5385-thread-1) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=54087}
   [junit4]   2> 1840076 ERROR (jetty-launcher-5385-thread-1) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 1840077 INFO  (jetty-launcher-5385-thread-1) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.0.0
   [junit4]   2> 1840077 INFO  (jetty-launcher-5385-thread-1) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1840077 INFO  (jetty-launcher-5385-thread-1) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1840077 INFO  (jetty-launcher-5385-thread-1) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2018-03-10T08:58:07.729Z
   [junit4]   2> 1840080 INFO  (zkConnectionManagerCallback-5390-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1840082 INFO  (jetty-launcher-5385-thread-1) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1840099 INFO  (jetty-launcher-5385-thread-1) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:54083/solr
   [junit4]   2> 1840102 INFO  (zkConnectionManagerCallback-5394-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1840104 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x1002e2d9ea30002, likely client has closed socket
   [junit4]   2> 1840107 INFO  (zkConnectionManagerCallback-5396-thread-1-processing-n:127.0.0.1:54087_solr) [n:127.0.0.1:54087_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1840188 INFO  (jetty-launcher-5385-thread-1) [n:127.0.0.1:54087_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1840191 INFO  (jetty-launcher-5385-thread-1) [n:127.0.0.1:54087_solr    ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:54087_solr
   [junit4]   2> 1840192 INFO  (jetty-launcher-5385-thread-1) [n:127.0.0.1:54087_solr    ] o.a.s.c.Overseer Overseer (id=72108367507816451-127.0.0.1:54087_solr-n_0000000000) starting
   [junit4]   2> 1840208 INFO  (jetty-launcher-5385-thread-1) [n:127.0.0.1:54087_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:54087_solr
   [junit4]   2> 1840209 DEBUG (OverseerAutoScalingTriggerThread-72108367507816451-127.0.0.1:54087_solr-n_0000000000) [n:127.0.0.1:54087_solr    ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and .scheduled_maintenance triggers
   [junit4]   2> 1840210 INFO  (OverseerStateUpdate-72108367507816451-127.0.0.1:54087_solr-n_0000000000) [n:127.0.0.1:54087_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1840210 DEBUG (OverseerAutoScalingTriggerThread-72108367507816451-127.0.0.1:54087_solr-n_0000000000) [n:127.0.0.1:54087_solr    ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1
   [junit4]   2> 1840211 DEBUG (OverseerAutoScalingTriggerThread-72108367507816451-127.0.0.1:54087_solr-n_0000000000) [n:127.0.0.1:54087_solr    ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:54087_solr]
   [junit4]   2> 1840211 DEBUG (OverseerAutoScalingTriggerThread-72108367507816451-127.0.0.1:54087_solr-n_0000000000) [n:127.0.0.1:54087_solr    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion -1
   [junit4]   2> 1840211 DEBUG (OverseerAutoScalingTriggerThread-72108367507816451-127.0.0.1:54087_solr-n_0000000000) [n:127.0.0.1:54087_solr    ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
   [junit4]   2> 1840216 DEBUG (OverseerAutoScalingTriggerThread-72108367507816451-127.0.0.1:54087_solr-n_0000000000) [n:127.0.0.1:54087_solr    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1840217 DEBUG (OverseerAutoScalingTriggerThread-72108367507816451-127.0.0.1:54087_solr-n_0000000000) [n:127.0.0.1:54087_solr    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
   [junit4]   2> 1840219 DEBUG (ScheduledTrigger-5869-thread-2) [n:127.0.0.1:54087_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1840391 INFO  (jetty-launcher-5385-thread-1) [n:127.0.0.1:54087_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_54087.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3ec1ae88
   [junit4]   2> 1840397 INFO  (jetty-launcher-5385-thread-1) [n:127.0.0.1:54087_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_54087.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3ec1ae88
   [junit4]   2> 1840397 INFO  (jetty-launcher-5385-thread-1) [n:127.0.0.1:54087_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_54087.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3ec1ae88
   [junit4]   2> 1840399 INFO  (jetty-launcher-5385-thread-1) [n:127.0.0.1:54087_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest_D52DB2283DB47881-001\tempDir-001\node1\.
   [junit4]   2> 1840423 INFO  (zkConnectionManagerCallback-5400-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1840430 INFO  (zkConnectionManagerCallback-5404-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1840432 INFO  (SUITE-ScheduledMaintenanceTriggerTest-seed#[D52DB2283DB47881]-worker) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1840432 INFO  (SUITE-ScheduledMaintenanceTriggerTest-seed#[D52DB2283DB47881]-worker) [    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:54083/solr ready
   [junit4]   2> 1840440 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and .scheduled_maintenance triggers
   [junit4]   2> 1840441 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 0
   [junit4]   2> 1840443 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10020_solr]
   [junit4]   2> 1840443 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion -1
   [junit4]   2> 1840443 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 0
   [junit4]   2> 1840445 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1840446 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion 0
   [junit4]   2> 1840446 DEBUG (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1840447 INFO  (TEST-ScheduledMaintenanceTriggerTest.testInactiveShardCleanup-seed#[D52DB2283DB47881]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testInactiveShardCleanup
   [junit4]   2> 1840468 DEBUG (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1840489 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1840511 DEBUG (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1840532 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1840552 DEBUG (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1840573 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1840595 DEBUG (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1840597 DEBUG (simCloudManagerPool-5875-thread-4) [    ] o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for ScheduledMaintenanceTriggerTest_collection1 / shard1: {"core_node1":{
   [junit4]   2>     "node_name":"127.0.0.1:10020_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> 1840597 DEBUG (simCloudManagerPool-5875-thread-5) [    ] o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for ScheduledMaintenanceTriggerTest_collection1 / shard1_1: {"core_node5":{
   [junit4]   2>     "node_name":"127.0.0.1:10020_solr",
   [junit4]   2>     "base_url":"http://127.0.0.1:10020/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> 1840597 DEBUG (simCloudManagerPool-5875-thread-6) [    ] o.a.s.c.a.s.SimClusterStateProvider -- elected new leader for ScheduledMaintenanceTriggerTest_collection1 / shard1_0: {"core_node4":{
   [junit4]   2>     "node_name":"127.0.0.1:10020_solr",
   [junit4]   2>     "base_url":"http://127.0.0.1:10020/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> 1840600 DEBUG (simCloudManagerPool-5875-thread-7) [    ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1840600 DEBUG (simCloudManagerPool-5875-thread-7) [    ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1
   [junit4]   2> 1840600 DEBUG (simCloudManagerPool-5875-thread-7) [    ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10020_solr]
   [junit4]   2> 1840601 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
   [junit4]   2> 1840601 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1840601 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
   [junit4]   2> 1840602 DEBUG (simCloudManagerPool-5875-thread-8) [    ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
   [junit4]   2> 1840602 DEBUG (simCloudManagerPool-5875-thread-8) [    ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 2
   [junit4]   2> 1840602 DEBUG (simCloudManagerPool-5875-thread-8) [    ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10020_solr]
   [junit4]   2> 1840603 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2
   [junit4]   2> 1840603 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 1840603 WARN  (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:58:10.095Z. Now: 2018-03-11T08:11:44.613Z
   [junit4]   2> 1840603 DEBUG (Simulated OverseerAutoScalingTriggerThread) [    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2
   [junit4]   2> 1840605 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f21b52fT90n6wl0zi34p5h95zmtycrogx",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672290095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755904613},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1840616 DEBUG (ScheduledTrigger-5876-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1840627 WARN  (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:58:12.095Z. Now: 2018-03-11T08:11:45.796Z
   [junit4]   2> 1840627 DEBUG (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f21bcffT90n6wl0zi34p5h95zmtycrogz",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672292095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755905796},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1840640 DEBUG (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1840649 WARN  (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:58:14.095Z. Now: 2018-03-11T08:11:46.899Z
   [junit4]   2> 1840649 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f21c4cfT90n6wl0zi34p5h95zmtycroh1",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672294095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755906899},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1840662 DEBUG (ScheduledTrigger-5876-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1840672 WARN  (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:58:16.095Z. Now: 2018-03-11T08:11:48.023Z
   [junit4]   2> 1840672 DEBUG (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f21cc9fT90n6wl0zi34p5h95zmtycroh3",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672296095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755908023},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1840684 DEBUG (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1840693 WARN  (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:58:18.095Z. Now: 2018-03-11T08:11:49.093Z
   [junit4]   2> 1840693 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f21d46fT90n6wl0zi34p5h95zmtycroh5",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672298095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755909093},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1840705 DEBUG (ScheduledTrigger-5876-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1840715 WARN  (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:58:20.095Z. Now: 2018-03-11T08:11:50.168Z
   [junit4]   2> 1840715 DEBUG (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f21dc3fT90n6wl0zi34p5h95zmtycroh7",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672300095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755910168},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1840726 DEBUG (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1840737 WARN  (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:58:22.095Z. Now: 2018-03-11T08:11:51.272Z
   [junit4]   2> 1840737 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f21e40fT90n6wl0zi34p5h95zmtycroh9",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672302095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755911272},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1840747 DEBUG (ScheduledTrigger-5876-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1840759 WARN  (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:58:24.095Z. Now: 2018-03-11T08:11:52.382Z
   [junit4]   2> 1840759 DEBUG (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f21ebdfT90n6wl0zi34p5h95zmtycrohb",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672304095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755912382},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1840768 DEBUG (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1840783 WARN  (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:58:26.095Z. Now: 2018-03-11T08:11:53.589Z
   [junit4]   2> 1840783 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f21f3afT90n6wl0zi34p5h95zmtycrohd",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672306095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755913589},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1840789 DEBUG (ScheduledTrigger-5876-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1840806 WARN  (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:58:28.095Z. Now: 2018-03-11T08:11:54.730Z
   [junit4]   2> 1840806 DEBUG (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f21fb7fT90n6wl0zi34p5h95zmtycrohf",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672308095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755914730},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1840811 DEBUG (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1840828 WARN  (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:58:30.095Z. Now: 2018-03-11T08:11:55.851Z
   [junit4]   2> 1840828 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f22034fT90n6wl0zi34p5h95zmtycrohh",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672310095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755915851},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1840831 DEBUG (ScheduledTrigger-5876-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1840852 DEBUG (ScheduledTrigger-5876-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1840855 WARN  (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:58:32.095Z. Now: 2018-03-11T08:11:57.205Z
   [junit4]   2> 1840855 DEBUG (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f220b1fT90n6wl0zi34p5h95zmtycrohj",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672312095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755917205},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1840873 DEBUG (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1840878 WARN  (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:58:34.095Z. Now: 2018-03-11T08:11:58.347Z
   [junit4]   2> 1840878 DEBUG (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f2212efT90n6wl0zi34p5h95zmtycrohl",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672314095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755918347},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1840895 DEBUG (ScheduledTrigger-5876-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1840900 WARN  (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:58:36.095Z. Now: 2018-03-11T08:11:59.447Z
   [junit4]   2> 1840900 DEBUG (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f221abfT90n6wl0zi34p5h95zmtycrohn",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672316095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755919447},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1840921 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1840931 WARN  (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:58:38.095Z. Now: 2018-03-11T08:12:00.993Z
   [junit4]   2> 1840931 DEBUG (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f22228fT90n6wl0zi34p5h95zmtycrohp",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672318095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755920993},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1840941 DEBUG (ScheduledTrigger-5876-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1840967 DEBUG (ScheduledTrigger-5876-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1840967 WARN  (ScheduledTrigger-5876-thread-1) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:58:40.095Z. Now: 2018-03-11T08:12:02.805Z
   [junit4]   2> 1840967 DEBUG (ScheduledTrigger-5876-thread-1) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f222a5fT90n6wl0zi34p5h95zmtycrohr",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672320095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755922805},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1840988 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1840989 WARN  (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:58:42.095Z. Now: 2018-03-11T08:12:03.889Z
   [junit4]   2> 1840989 DEBUG (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f22322fT90n6wl0zi34p5h95zmtycroht",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672322095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755923889},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1841009 DEBUG (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841011 WARN  (ScheduledTrigger-5876-thread-1) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:58:44.095Z. Now: 2018-03-11T08:12:04.981Z
   [junit4]   2> 1841011 DEBUG (ScheduledTrigger-5876-thread-1) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f2239ffT90n6wl0zi34p5h95zmtycrohv",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672324095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755924981},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1841029 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841032 WARN  (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:58:46.095Z. Now: 2018-03-11T08:12:06.047Z
   [junit4]   2> 1841032 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f2241cfT90n6wl0zi34p5h95zmtycrohx",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672326095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755926047},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1841050 DEBUG (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841055 WARN  (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:58:48.095Z. Now: 2018-03-11T08:12:07.175Z
   [junit4]   2> 1841055 DEBUG (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f22499fT90n6wl0zi34p5h95zmtycrohz",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672328095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755927175},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1841079 DEBUG (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841079 WARN  (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:58:50.095Z. Now: 2018-03-11T08:12:08.393Z
   [junit4]   2> 1841080 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f22516fT90n6wl0zi34p5h95zmtycroi1",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672330095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755928393},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1841101 DEBUG (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841101 WARN  (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:58:52.095Z. Now: 2018-03-11T08:12:09.478Z
   [junit4]   2> 1841101 DEBUG (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f22593fT90n6wl0zi34p5h95zmtycroi3",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672332095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755929478},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1841122 DEBUG (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841122 WARN  (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:58:54.095Z. Now: 2018-03-11T08:12:10.551Z
   [junit4]   2> 1841123 DEBUG (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f22610fT90n6wl0zi34p5h95zmtycroi5",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672334095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755930551},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1841143 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841144 WARN  (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:58:56.095Z. Now: 2018-03-11T08:12:11.653Z
   [junit4]   2> 1841144 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f2268dfT90n6wl0zi34p5h95zmtycroi7",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672336095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755931653},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1841169 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841169 WARN  (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:58:58.095Z. Now: 2018-03-11T08:12:12.923Z
   [junit4]   2> 1841170 DEBUG (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f2270afT90n6wl0zi34p5h95zmtycroi9",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672338095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755932923},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1841190 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841192 WARN  (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:59:00.095Z. Now: 2018-03-11T08:12:14.052Z
   [junit4]   2> 1841193 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f22787fT90n6wl0zi34p5h95zmtycroib",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672340095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755934052},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1841211 DEBUG (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841214 WARN  (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:59:02.095Z. Now: 2018-03-11T08:12:15.128Z
   [junit4]   2> 1841214 DEBUG (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f22804fT90n6wl0zi34p5h95zmtycroid",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672342095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755935128},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1841221 DEBUG (ScheduledTrigger-5869-thread-1) [n:127.0.0.1:54087_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841232 DEBUG (ScheduledTrigger-5876-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841243 WARN  (ScheduledTrigger-5876-thread-1) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:59:04.095Z. Now: 2018-03-11T08:12:16.592Z
   [junit4]   2> 1841244 DEBUG (ScheduledTrigger-5876-thread-1) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f22881fT90n6wl0zi34p5h95zmtycroif",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672344095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755936592},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1841255 DEBUG (ScheduledTrigger-5876-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841276 DEBUG (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841276 WARN  (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:59:06.095Z. Now: 2018-03-11T08:12:18.241Z
   [junit4]   2> 1841276 DEBUG (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f228fefT90n6wl0zi34p5h95zmtycroih",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672346095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755938241},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1841297 DEBUG (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841298 WARN  (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:59:08.095Z. Now: 2018-03-11T08:12:19.327Z
   [junit4]   2> 1841298 DEBUG (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f2297bfT90n6wl0zi34p5h95zmtycroij",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672348095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755939327},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1841317 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841320 WARN  (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:59:10.095Z. Now: 2018-03-11T08:12:20.446Z
   [junit4]   2> 1841320 DEBUG (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f229f8fT90n6wl0zi34p5h95zmtycroil",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672350095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755940446},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1841338 DEBUG (ScheduledTrigger-5876-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841342 WARN  (ScheduledTrigger-5876-thread-1) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:59:12.095Z. Now: 2018-03-11T08:12:21.526Z
   [junit4]   2> 1841342 DEBUG (ScheduledTrigger-5876-thread-1) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f22a75fT90n6wl0zi34p5h95zmtycroin",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672352095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755941526},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1841375 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841399 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841399 WARN  (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:59:14.095Z. Now: 2018-03-11T08:12:24.386Z
   [junit4]   2> 1841399 DEBUG (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f22af2fT90n6wl0zi34p5h95zmtycroip",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672354095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755944386},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1841420 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841421 WARN  (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:59:16.095Z. Now: 2018-03-11T08:12:25.488Z
   [junit4]   2> 1841421 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f22b6ffT90n6wl0zi34p5h95zmtycroir",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672356095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755945488},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1841443 DEBUG (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841443 WARN  (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:59:18.095Z. Now: 2018-03-11T08:12:26.589Z
   [junit4]   2> 1841443 DEBUG (ScheduledTrigger-5876-thread-2) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f22becfT90n6wl0zi34p5h95zmtycroit",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672358095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755946589},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1841464 DEBUG (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841465 WARN  (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:59:20.095Z. Now: 2018-03-11T08:12:27.684Z
   [junit4]   2> 1841465 DEBUG (ScheduledTrigger-5876-thread-3) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f22c69fT90n6wl0zi34p5h95zmtycroiv",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672360095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755947684},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1841485 DEBUG (ScheduledTrigger-5876-thread-1) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841487 WARN  (ScheduledTrigger-5876-thread-1) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:59:22.095Z. Now: 2018-03-11T08:12:28.790Z
   [junit4]   2> 1841487 DEBUG (ScheduledTrigger-5876-thread-1) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f22ce6fT90n6wl0zi34p5h95zmtycroix",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672362095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755948790},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1841506 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841509 WARN  (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:59:24.095Z. Now: 2018-03-11T08:12:29.884Z
   [junit4]   2> 1841509 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f22d63fT90n6wl0zi34p5h95zmtycroiz",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672364095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755949884},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1841531 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841531 WARN  (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:59:26.095Z. Now: 2018-03-11T08:12:30.993Z
   [junit4]   2> 1841531 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f22de0fT90n6wl0zi34p5h95zmtycroj1",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672366095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755950993},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1841555 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841555 WARN  (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:59:28.095Z. Now: 2018-03-11T08:12:32.196Z
   [junit4]   2> 1841555 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f22e5dfT90n6wl0zi34p5h95zmtycroj3",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672368095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755952196},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1841576 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841577 WARN  (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:59:30.095Z. Now: 2018-03-11T08:12:33.284Z
   [junit4]   2> 1841577 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f22edafT90n6wl0zi34p5h95zmtycroj5",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672370095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755953284},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1841605 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841605 WARN  (ScheduledTrigger-5876-thread-1) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:59:32.095Z. Now: 2018-03-11T08:12:34.714Z
   [junit4]   2> 1841605 DEBUG (ScheduledTrigger-5876-thread-1) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f22f57fT90n6wl0zi34p5h95zmtycroj7",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672372095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755954714},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1841639 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
   [junit4]   2> 1841639 WARN  (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:59:34.095Z. Now: 2018-03-11T08:12:36.400Z
   [junit4]   2> 1841639 DEBUG (ScheduledTrigger-5876-thread-4) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f22fd4fT90n6wl0zi34p5h95zmtycroj9",
   [junit4]   2>   "source":".scheduled_maintenance",
   [junit4]   2>   "eventTime":1520672374095,
   [junit4]   2>   "eventType":"SCHEDULED",
   [junit4]   2>   "properties":{"actualEventTime":1520755956400},
   [junit4]   2>   "ignored":true}
   [junit4]   2> 1841665 WARN  (ScheduledTrigger-5876-thread-1) [    ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-03-10T08:59:36.095Z. Now: 2018-03-11T08:12:37.684Z
   [junit4]   2> 1841665 DEBUG (ScheduledTrigger-5876-thread-1) [    ] o.a.s.c.a.ScheduledTriggers -------- Ignoring event: {
   [junit4]   2>   "id":"1620f23051fT90n6wl0zi34p5h95zmtycr

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

entIndexWithAdditions
   [junit4] OK      0.48s J1 | TestBackwardsCompatibility.testUpgradeThenMultipleCommits
   [junit4] OK      0.00s J1 | TestBackwardsCompatibility.testAllVersionsTested
   [junit4] OK      0.65s J1 | TestBackwardsCompatibility.testFullyMergeOldIndex
   [junit4] OK      0.50s J1 | TestBackwardsCompatibility.testAddOldIndexes
   [junit4] OK      0.09s J1 | TestBackwardsCompatibility.testMoreTerms
   [junit4] OK      0.01s J1 | TestBackwardsCompatibility.testUpgradeEmptyOldIndex
   [junit4] IGNOR/A 0.00s J1 | TestBackwardsCompatibility.testCreateSortedIndex
   [junit4]    > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
   [junit4] OK      0.83s J1 | TestBackwardsCompatibility.testAddOldIndexesReader
   [junit4] OK      0.14s J1 | TestBackwardsCompatibility.testOldVersions
   [junit4] OK      0.26s J1 | TestBackwardsCompatibility.testDocValuesUpdates
   [junit4] OK      0.18s J1 | TestBackwardsCompatibility.testNextIntoWrongField
   [junit4] OK      0.19s J1 | TestBackwardsCompatibility.testAllIndexesUseDefaultCodec
   [junit4] OK      0.01s J1 | TestBackwardsCompatibility.testIndexCreatedVersion
   [junit4] IGNOR/A 0.00s J1 | TestBackwardsCompatibility.testCreateIndexWithDocValuesUpdates
   [junit4]    > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
   [junit4] IGNOR/A 0.00s J1 | TestBackwardsCompatibility.testCreateNoCFS
   [junit4]    > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
   [junit4] OK      3.93s J1 | TestBackwardsCompatibility.testUnsupportedOldIndexes
   [junit4] IGNOR/A 0.00s J1 | TestBackwardsCompatibility.testCreateMoreTermsIndex
   [junit4]    > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
   [junit4] OK      0.73s J1 | TestBackwardsCompatibility.testUpgradeWithNRTReader
   [junit4] OK      1.23s J1 | TestBackwardsCompatibility.testUpgradeOldIndex
   [junit4] IGNOR/A 0.00s J1 | TestBackwardsCompatibility.testCreateEmptyIndex
   [junit4]    > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
   [junit4] IGNOR/A 0.00s J1 | TestBackwardsCompatibility.testCreateSingleSegmentNoCFS
   [junit4]    > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
   [junit4] OK      0.55s J1 | TestBackwardsCompatibility.testSearchOldIndex
   [junit4] OK      0.00s J1 | TestBackwardsCompatibility.testAllVersionHaveCfsAndNocfs
   [junit4] OK      1.12s J1 | TestBackwardsCompatibility.testIndexOldIndex
   [junit4] IGNOR/A 0.00s J1 | TestBackwardsCompatibility.testCreateSingleSegmentCFS
   [junit4]    > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
   [junit4] OK      0.65s J1 | TestBackwardsCompatibility.testSortedIndex
   [junit4] Completed [4/5] on J1 in 20.85s, 30 tests, 8 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestBackwardsCompatibility
   [junit4] OK      5.51s J0 | TestBackwardsCompatibility.testCommandLineArgs
   [junit4] IGNOR/A 0.00s J0 | TestBackwardsCompatibility.testCreateCFS
   [junit4]    > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
   [junit4] OK      0.29s J0 | TestBackwardsCompatibility.testIndexOldIndexNoAdds
   [junit4] OK      0.00s J0 | TestBackwardsCompatibility.testUpgradeOldSingleSegmentIndexWithAdditions
   [junit4] OK      0.16s J0 | TestBackwardsCompatibility.testUpgradeThenMultipleCommits
   [junit4] OK      0.00s J0 | TestBackwardsCompatibility.testAllVersionsTested
   [junit4] OK      0.20s J0 | TestBackwardsCompatibility.testFullyMergeOldIndex
   [junit4] OK      0.25s J0 | TestBackwardsCompatibility.testAddOldIndexes
   [junit4] OK      0.08s J0 | TestBackwardsCompatibility.testMoreTerms
   [junit4] OK      0.01s J0 | TestBackwardsCompatibility.testUpgradeEmptyOldIndex
   [junit4] IGNOR/A 0.00s J0 | TestBackwardsCompatibility.testCreateSortedIndex
   [junit4]    > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
   [junit4] OK      0.30s J0 | TestBackwardsCompatibility.testAddOldIndexesReader
   [junit4] OK      0.06s J0 | TestBackwardsCompatibility.testOldVersions
   [junit4] OK      0.11s J0 | TestBackwardsCompatibility.testDocValuesUpdates
   [junit4] OK      0.06s J0 | TestBackwardsCompatibility.testNextIntoWrongField
   [junit4] OK      0.04s J0 | TestBackwardsCompatibility.testAllIndexesUseDefaultCodec
   [junit4] OK      0.01s J0 | TestBackwardsCompatibility.testIndexCreatedVersion
   [junit4] IGNOR/A 0.00s J0 | TestBackwardsCompatibility.testCreateIndexWithDocValuesUpdates
   [junit4]    > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
   [junit4] IGNOR/A 0.00s J0 | TestBackwardsCompatibility.testCreateNoCFS
   [junit4]    > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
   [junit4] OK      4.85s J0 | TestBackwardsCompatibility.testUnsupportedOldIndexes
   [junit4] IGNOR/A 0.00s J0 | TestBackwardsCompatibility.testCreateMoreTermsIndex
   [junit4]    > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
   [junit4] OK      0.28s J0 | TestBackwardsCompatibility.testUpgradeWithNRTReader
   [junit4] OK      0.22s J0 | TestBackwardsCompatibility.testUpgradeOldIndex
   [junit4] IGNOR/A 0.00s J0 | TestBackwardsCompatibility.testCreateEmptyIndex
   [junit4]    > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
   [junit4] IGNOR/A 0.00s J0 | TestBackwardsCompatibility.testCreateSingleSegmentNoCFS
   [junit4]    > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
   [junit4] OK      0.27s J0 | TestBackwardsCompatibility.testSearchOldIndex
   [junit4] OK      0.00s J0 | TestBackwardsCompatibility.testAllVersionHaveCfsAndNocfs
   [junit4] OK      0.40s J0 | TestBackwardsCompatibility.testIndexOldIndex
   [junit4] IGNOR/A 0.00s J0 | TestBackwardsCompatibility.testCreateSingleSegmentCFS
   [junit4]    > Assumption #1: backcompat creation tests must be run with -Dtests.bwcdir=/path/to/write/indexes
   [junit4] OK      0.36s J0 | TestBackwardsCompatibility.testSortedIndex
   [junit4] Completed [5/5] on J0 in 15.53s, 30 tests, 8 skipped
   [junit4] 
   [junit4] JVM J0:     0.62 ..    66.12 =    65.50s
   [junit4] JVM J1:     0.62 ..    50.41 =    49.79s
   [junit4] Execution time total: 1 minute 6 seconds
   [junit4] Tests summary: 5 suites, 150 tests, 40 ignored (40 assumptions)
   [junit4] Could not remove temporary path: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\backward-codecs\test\J0 (java.nio.file.DirectoryNotEmptyException: Remaining files: [C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\backward-codecs\test\J0\temp])
   [junit4] Could not remove temporary path: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\backward-codecs\test\J1 (java.nio.file.DirectoryNotEmptyException: Remaining files: [C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\backward-codecs\test\J1\temp])
     [echo] 5 slowest tests:
[junit4:tophints]  22.11s | org.apache.lucene.index.TestBackwardsCompatibility
[junit4:tophints]   0.69s | org.apache.lucene.index.TestIndexWriterOnOldIndex
[junit4:tophints]   0.64s | org.apache.lucene.index.TestManyPointsInOldIndex

-check-totals:

test-nocompile:

BUILD SUCCESSFUL
Total time: 1 minute 7 seconds
[repro] Failures:
[repro]   0/5 failed: org.apache.lucene.index.TestBackwardsCompatibility
[repro]   0/5 failed: org.apache.solr.update.processor.TimeRoutedAliasUpdateProcessorTest
[repro]   3/5 failed: org.apache.solr.cloud.autoscaling.ScheduledMaintenanceTriggerTest
[repro] Exiting with code 1

C:\Users\jenkins\workspace\Lucene-Solr-master-Windows>IF EXIST lucene\build move /y lucene\build lucene\build.repro 
        1 dir(s) moved.

C:\Users\jenkins\workspace\Lucene-Solr-master-Windows>IF EXIST solr\build move /y solr\build solr\build.repro 
        1 dir(s) moved.

C:\Users\jenkins\workspace\Lucene-Solr-master-Windows>IF EXIST lucene\build.orig move /y lucene\build.orig lucene\build 
        1 dir(s) moved.

C:\Users\jenkins\workspace\Lucene-Solr-master-Windows>IF EXIST solr\build.orig move /y solr\build.orig solr\build 
        1 dir(s) moved.

C:\Users\jenkins\workspace\Lucene-Solr-master-Windows>exit 0 
Archiving artifacts
Setting ANT_1_8_2_HOME=C:\Users\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=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting ANT_1_8_2_HOME=C:\Users\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=2eeed51cdf006bdee7dec87b6adf144e7cc0d56e, workspace=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows
[WARNINGS] Computing warning deltas based on reference build #7212
Recording test results
Setting ANT_1_8_2_HOME=C:\Users\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=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2

Mime
View raw message