You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2018/04/26 23:56:35 UTC
[JENKINS] Lucene-Solr-7.3-Windows (64bit/jdk-9.0.4) - Build # 32 -
Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.3-Windows/32/
Java: 64bit/jdk-9.0.4 -XX:+UseCompressedOops -XX:+UseSerialGC
6 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.SampleTest
Error Message:
Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\build\solr-core\test\J0\temp\solr.SampleTest_A54A92EA4EF57907-001\init-core-data-001: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\build\solr-core\test\J0\temp\solr.SampleTest_A54A92EA4EF57907-001\init-core-data-001 C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\build\solr-core\test\J0\temp\solr.SampleTest_A54A92EA4EF57907-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\build\solr-core\test\J0\temp\solr.SampleTest_A54A92EA4EF57907-001
Stack Trace:
java.io.IOException: Could not remove the following files (in the order of attempts):
C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\build\solr-core\test\J0\temp\solr.SampleTest_A54A92EA4EF57907-001\init-core-data-001: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\build\solr-core\test\J0\temp\solr.SampleTest_A54A92EA4EF57907-001\init-core-data-001
C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\build\solr-core\test\J0\temp\solr.SampleTest_A54A92EA4EF57907-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\build\solr-core\test\J0\temp\solr.SampleTest_A54A92EA4EF57907-001
at __randomizedtesting.SeedInfo.seed([A54A92EA4EF57907]: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.base/java.lang.Thread.run(Thread.java:844)
FAILED: org.apache.solr.cloud.autoscaling.TriggerIntegrationTest.testScheduledTrigger
Error Message:
null Live Nodes: [127.0.0.1:57204_solr, 127.0.0.1:57319_solr] Last available state: null
Stack Trace:
java.lang.AssertionError:
null
Live Nodes: [127.0.0.1:57204_solr, 127.0.0.1:57319_solr]
Last available state: null
at __randomizedtesting.SeedInfo.seed([A54A92EA4EF57907:3651DA9810082233]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.apache.solr.cloud.SolrCloudTestCase.waitForState(SolrCloudTestCase.java:269)
at org.apache.solr.cloud.autoscaling.TriggerIntegrationTest.testScheduledTrigger(TriggerIntegrationTest.java:1660)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
FAILED: org.apache.solr.cloud.autoscaling.TriggerIntegrationTest.testEventQueue
Error Message:
action wasn't interrupted
Stack Trace:
java.lang.AssertionError: action wasn't interrupted
at __randomizedtesting.SeedInfo.seed([A54A92EA4EF57907:6CFFD0444792BFF2]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.apache.solr.cloud.autoscaling.TriggerIntegrationTest.testEventQueue(TriggerIntegrationTest.java:743)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
FAILED: org.apache.solr.cloud.autoscaling.TriggerIntegrationTest.testEventQueue
Error Message:
action wasn't interrupted
Stack Trace:
java.lang.AssertionError: action wasn't interrupted
at __randomizedtesting.SeedInfo.seed([A54A92EA4EF57907:6CFFD0444792BFF2]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.apache.solr.cloud.autoscaling.TriggerIntegrationTest.testEventQueue(TriggerIntegrationTest.java:743)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
FAILED: org.apache.solr.cloud.autoscaling.TriggerIntegrationTest.testEventQueue
Error Message:
action wasn't interrupted
Stack Trace:
java.lang.AssertionError: action wasn't interrupted
at __randomizedtesting.SeedInfo.seed([A54A92EA4EF57907:6CFFD0444792BFF2]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.apache.solr.cloud.autoscaling.TriggerIntegrationTest.testEventQueue(TriggerIntegrationTest.java:743)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
FAILED: org.apache.solr.cloud.autoscaling.TriggerIntegrationTest.testEventQueue
Error Message:
action wasn't interrupted
Stack Trace:
java.lang.AssertionError: action wasn't interrupted
at __randomizedtesting.SeedInfo.seed([A54A92EA4EF57907:6CFFD0444792BFF2]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.apache.solr.cloud.autoscaling.TriggerIntegrationTest.testEventQueue(TriggerIntegrationTest.java:743)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
Build Log:
[...truncated 12651 lines...]
[junit4] Suite: org.apache.solr.SampleTest
[junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\build\solr-core\test\J0\temp\solr.SampleTest_A54A92EA4EF57907-001\init-core-data-001
[junit4] 2> 534893 WARN (SUITE-SampleTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=26 numCloses=26
[junit4] 2> 534894 INFO (SUITE-SampleTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 534896 INFO (SUITE-SampleTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, clientAuth=0.0/0.0)
[junit4] 2> 534897 INFO (SUITE-SampleTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 534898 INFO (SUITE-SampleTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 534898 INFO (SUITE-SampleTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-7.3-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-7.3-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 534927 INFO (SUITE-SampleTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.1
[junit4] 2> 534937 INFO (SUITE-SampleTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 534938 INFO (SUITE-SampleTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 534989 INFO (SUITE-SampleTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@26362f3a
[junit4] 2> 534998 INFO (SUITE-SampleTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@26362f3a
[junit4] 2> 534998 INFO (SUITE-SampleTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@26362f3a
[junit4] 2> 534998 INFO (coreLoadExecutor-3114-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 535004 INFO (coreLoadExecutor-3114-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-7.3-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-7.3-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 535041 INFO (coreLoadExecutor-3114-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.1
[junit4] 2> 535069 INFO (coreLoadExecutor-3114-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 535072 INFO (coreLoadExecutor-3114-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 535072 INFO (coreLoadExecutor-3114-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\core\src\test-files\solr\collection1, trusted=true
[junit4] 2> 535072 INFO (coreLoadExecutor-3114-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@26362f3a
[junit4] 2> 535072 INFO (coreLoadExecutor-3114-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 535072 INFO (coreLoadExecutor-3114-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\core\src\test-files\solr\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\build\solr-core\test\J0\temp\solr.SampleTest_A54A92EA4EF57907-001\init-core-data-001\]
[junit4] 2> 535080 INFO (coreLoadExecutor-3114-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=40, maxMergeAtOnceExplicit=25, maxMergedSegmentMB=4.35546875, floorSegmentMB=0.32421875, forceMergeDeletesPctAllowed=17.53420945802602, segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.40508098006706994
[junit4] 2> 535119 INFO (coreLoadExecutor-3114-thread-1) [ x:collection1] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=60
[junit4] 2> 535227 INFO (coreLoadExecutor-3114-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 535227 INFO (coreLoadExecutor-3114-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 535229 INFO (coreLoadExecutor-3114-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=23, maxMergeAtOnceExplicit=42, maxMergedSegmentMB=64.4677734375, floorSegmentMB=1.3310546875, forceMergeDeletesPctAllowed=28.37647198808324, segmentsPerTier=28.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 535229 INFO (coreLoadExecutor-3114-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@2a8c8305[collection1] main]
[junit4] 2> 535229 WARN (coreLoadExecutor-3114-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\core\src\test-files\solr\collection1\conf; switching to use InMemory storage instead.
[junit4] 2> 535232 INFO (coreLoadExecutor-3114-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 535234 INFO (searcherExecutor-3115-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2a8c8305[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 535234 INFO (SUITE-SampleTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 535236 INFO (TEST-SampleTest.testAdvanced-seed#[A54A92EA4EF57907]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testAdvanced
[junit4] 2> 535238 INFO (TEST-SampleTest.testAdvanced-seed#[A54A92EA4EF57907]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4059]} 0 0
[junit4] 2> 535240 INFO (TEST-SampleTest.testAdvanced-seed#[A54A92EA4EF57907]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4059]} 0 0
[junit4] 2> 535240 INFO (TEST-SampleTest.testAdvanced-seed#[A54A92EA4EF57907]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4055]} 0 0
[junit4] 2> 535242 INFO (TEST-SampleTest.testAdvanced-seed#[A54A92EA4EF57907]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 535242 INFO (TEST-SampleTest.testAdvanced-seed#[A54A92EA4EF57907]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@ae7ae1b commitCommandVersion:0
[junit4] 2> 535291 INFO (TEST-SampleTest.testAdvanced-seed#[A54A92EA4EF57907]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@58fa2763[collection1] main]
[junit4] 2> 535291 INFO (TEST-SampleTest.testAdvanced-seed#[A54A92EA4EF57907]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 535291 INFO (searcherExecutor-3115-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@58fa2763[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.3.1):c3)))}
[junit4] 2> 535291 INFO (TEST-SampleTest.testAdvanced-seed#[A54A92EA4EF57907]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 52
[junit4] 2> 535291 INFO (TEST-SampleTest.testAdvanced-seed#[A54A92EA4EF57907]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 535291 WARN (TEST-SampleTest.testAdvanced-seed#[A54A92EA4EF57907]) [ ] o.a.s.u.DirectUpdateHandler2 Starting optimize... Reading and rewriting the entire index! Use with care.
[junit4] 2> 535320 INFO (TEST-SampleTest.testAdvanced-seed#[A54A92EA4EF57907]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@ae7ae1b commitCommandVersion:0
[junit4] 2> 535395 INFO (TEST-SampleTest.testAdvanced-seed#[A54A92EA4EF57907]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@73046f26[collection1] main]
[junit4] 2> 535395 INFO (searcherExecutor-3115-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@73046f26[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.3.1):C3)))}
[junit4] 2> 535395 INFO (TEST-SampleTest.testAdvanced-seed#[A54A92EA4EF57907]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 535395 INFO (TEST-SampleTest.testAdvanced-seed#[A54A92EA4EF57907]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{optimize=} 0 107
[junit4] 2> 535404 INFO (TEST-SampleTest.testAdvanced-seed#[A54A92EA4EF57907]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=subject:Hoss&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=1
[junit4] 2> 535405 INFO (TEST-SampleTest.testAdvanced-seed#[A54A92EA4EF57907]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=Mack+Daddy&qt=/crazy_custom_qt&start=100&rows=200&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 535406 INFO (TEST-SampleTest.testAdvanced-seed#[A54A92EA4EF57907]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=Mack+Daddy&qt=/crazy_custom_qt&start=100&rows=200&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 535407 INFO (TEST-SampleTest.testAdvanced-seed#[A54A92EA4EF57907]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testAdvanced
[junit4] 2> 535410 INFO (TEST-SampleTest.testSimple-seed#[A54A92EA4EF57907]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testSimple
[junit4] 2> 535410 INFO (TEST-SampleTest.testSimple-seed#[A54A92EA4EF57907]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4055]} 0 0
[junit4] 2> 535411 INFO (TEST-SampleTest.testSimple-seed#[A54A92EA4EF57907]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4056]} 0 0
[junit4] 2> 535411 INFO (TEST-SampleTest.testSimple-seed#[A54A92EA4EF57907]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 535411 INFO (TEST-SampleTest.testSimple-seed#[A54A92EA4EF57907]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@ae7ae1b commitCommandVersion:0
[junit4] 2> 535598 INFO (TEST-SampleTest.testSimple-seed#[A54A92EA4EF57907]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@479757d3[collection1] main]
[junit4] 2> 535601 INFO (searcherExecutor-3115-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@479757d3[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.3.1):C3/1:delGen=1) Uninverting(_2(7.3.1):c2)))}
[junit4] 2> 535601 INFO (TEST-SampleTest.testSimple-seed#[A54A92EA4EF57907]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 535601 INFO (TEST-SampleTest.testSimple-seed#[A54A92EA4EF57907]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 189
[junit4] 2> 535602 INFO (TEST-SampleTest.testSimple-seed#[A54A92EA4EF57907]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 535602 WARN (TEST-SampleTest.testSimple-seed#[A54A92EA4EF57907]) [ ] o.a.s.u.DirectUpdateHandler2 Starting optimize... Reading and rewriting the entire index! Use with care.
[junit4] 2> 535635 INFO (TEST-SampleTest.testSimple-seed#[A54A92EA4EF57907]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@ae7ae1b commitCommandVersion:0
[junit4] 2> 535748 INFO (TEST-SampleTest.testSimple-seed#[A54A92EA4EF57907]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1e4546c9[collection1] main]
[junit4] 2> 535748 INFO (TEST-SampleTest.testSimple-seed#[A54A92EA4EF57907]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 535750 INFO (searcherExecutor-3115-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1e4546c9[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(7.3.1):C4)))}
[junit4] 2> 535757 INFO (TEST-SampleTest.testSimple-seed#[A54A92EA4EF57907]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{optimize=} 0 154
[junit4] 2> 535758 INFO (TEST-SampleTest.testSimple-seed#[A54A92EA4EF57907]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=subject:Hoss&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
[junit4] 2> 535758 INFO (TEST-SampleTest.testSimple-seed#[A54A92EA4EF57907]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testSimple
[junit4] 2> 535759 INFO (SUITE-SampleTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 535759 INFO (SUITE-SampleTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1740818516
[junit4] 2> 535759 INFO (SUITE-SampleTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 535759 INFO (SUITE-SampleTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1c48ee7b: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@7eb2d98d
[junit4] 2> 535764 INFO (SUITE-SampleTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 535764 INFO (SUITE-SampleTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@46eb4aff: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@5227e391
[junit4] 2> 535768 INFO (SUITE-SampleTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 535768 INFO (SUITE-SampleTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@7bad4c3: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@7ef798a9
[junit4] 2> 535769 INFO (coreCloseExecutor-3119-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@602aee50
[junit4] 2> 535770 INFO (coreCloseExecutor-3119-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=1613426256
[junit4] 2> 535770 INFO (coreCloseExecutor-3119-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5b950f95: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@4c7073e0
[junit4] 2> 535780 INFO (SUITE-SampleTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.SolrTestCaseJ4 ------------------------------------------------------- Done waiting for tracked resources to be released
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70), sim=RandomSimilarity(queryNorm=false): {}, locale=nl-CW, timezone=Pacific/Fiji
[junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 9.0.4 (64-bit)/cpus=3,threads=1,free=102196168,total=364597248
[junit4] 2> NOTE: All tests run in this JVM: [TestNumericTerms32, TestIBSimilarityFactory, FieldMutatingUpdateProcessorTest, TestXmlQParser, SpellingQueryConverterTest, TestFunctionQuery, DateMathParserTest, TestConfigSetProperties, TestConfigSetsAPI, AnalysisAfterCoreReloadTest, SignatureUpdateProcessorFactoryTest, DocValuesMissingTest, TestSolrXml, AutoAddReplicasIntegrationTest, ReplaceNodeTest, ResourceLoaderTest, TestScoreJoinQPNoScore, HdfsSyncSliceTest, XmlUpdateRequestHandlerTest, TestInitParams, TestImplicitCoreProperties, TestGraphTermsQParserPlugin, TestSolrCloudWithHadoopAuthPlugin, TestSortableTextField, SolrTestCaseJ4Test, BooleanFieldTest, TestPhraseSuggestions, HttpTriggerListenerTest, OpenExchangeRatesOrgProviderTest, TestSolrCoreSnapshots, TestAuthenticationFramework, BasicAuthStandaloneTest, TestSuggestSpellingConverter, UtilsToolTest, ShardSplitTest, ConvertedLegacyTest, TestLeaderElectionZkExpiry, PathHierarchyTokenizerFactoryTest, TestReplicationHandlerBackup, TestCloudNestedDocsSort, TestConfigOverlay, LIRRollingUpdatesTest, TestQuerySenderNoQuery, TestAnalyzeInfixSuggestions, DistribJoinFromCollectionTest, SolrInfoBeanTest, CustomHighlightComponentTest, TestSchemaSimilarityResource, TestCoreContainer, TestRandomFlRTGCloud, DistributedExpandComponentTest, TestHighlightDedupGrouping, ManagedSchemaRoundRobinCloudTest, TestNumericTokenStream, TestUtils, TestExecutePlanAction, TestObjectReleaseTracker, TestAuthorizationFramework, TestUseDocValuesAsStored2, HdfsRecoveryZkTest, DistributedQueryComponentOptimizationTest, TestSolrJ, AnalyticsQueryTest, SegmentsInfoRequestHandlerTest, TestDocTermOrds, BinaryUpdateRequestHandlerTest, MoveReplicaTest, SolrIndexMetricsTest, TestConfigsApi, TestSubQueryTransformer, NumericFieldsTest, TestSolrConfigHandlerConcurrent, TestStressCloudBlindAtomicUpdates, TestCollapseQParserPlugin, TestRealTimeGet, TestPushWriter, TestStressLiveNodes, TemplateUpdateProcessorTest, TestReloadAndDeleteDocs, TestRestoreCore, AlternateDirectoryTest, TestFieldCollectionResource, BigEndianAscendingWordDeserializerTest, TestZkChroot, TestPerFieldSimilarityWithDefaultOverride, TestSolrCLIRunExample, UpdateLogTest, ConfigSetsAPITest, PolyFieldTest, DeleteNodeTest, TestDefaultStatsCache, TestBM25SimilarityFactory, SimpleMLTQParserTest, TestOmitPositions, NumberUtilsTest, TestExclusionRuleCollectionAccess, SolrCloudExampleTest, TestFileDictionaryLookup, MetricUtilsTest, CdcrVersionReplicationTest, SampleTest]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SampleTest -Dtests.seed=A54A92EA4EF57907 -Dtests.slow=true -Dtests.locale=nl-CW -Dtests.timezone=Pacific/Fiji -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J0 | SampleTest (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-7.3-Windows\solr\build\solr-core\test\J0\temp\solr.SampleTest_A54A92EA4EF57907-001\init-core-data-001: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\build\solr-core\test\J0\temp\solr.SampleTest_A54A92EA4EF57907-001\init-core-data-001
[junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\build\solr-core\test\J0\temp\solr.SampleTest_A54A92EA4EF57907-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\build\solr-core\test\J0\temp\solr.SampleTest_A54A92EA4EF57907-001
[junit4] > at __randomizedtesting.SeedInfo.seed([A54A92EA4EF57907]:0)
[junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] Completed [161/783 (1!)] on J0 in 0.99s, 2 tests, 1 error <<< FAILURES!
[...truncated 722 lines...]
[junit4] Suite: org.apache.solr.cloud.autoscaling.TriggerIntegrationTest
[junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.TriggerIntegrationTest_A54A92EA4EF57907-001\init-core-data-001
[junit4] 2> 1268149 WARN (SUITE-TriggerIntegrationTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=56 numCloses=56
[junit4] 2> 1268156 INFO (SUITE-TriggerIntegrationTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 1268157 INFO (SUITE-TriggerIntegrationTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, clientAuth=0.0/0.0)
[junit4] 2> 1268157 INFO (SUITE-TriggerIntegrationTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1268157 INFO (SUITE-TriggerIntegrationTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.TriggerIntegrationTest_A54A92EA4EF57907-001\tempDir-001
[junit4] 2> 1268157 INFO (SUITE-TriggerIntegrationTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1268157 INFO (Thread-3234) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1268157 INFO (Thread-3234) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1268182 ERROR (Thread-3234) [ ] 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> 1268258 INFO (SUITE-TriggerIntegrationTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:57025
[junit4] 2> 1268268 INFO (zkConnectionManagerCallback-5114-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1268315 INFO (jetty-launcher-5111-thread-1) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: ????-??-??T??:??:??-04:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 1268317 INFO (jetty-launcher-5111-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1268317 INFO (jetty-launcher-5111-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1268317 INFO (jetty-launcher-5111-thread-1) [ ] o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 1268318 INFO (jetty-launcher-5111-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4fc4cc83{/solr,null,AVAILABLE}
[junit4] 2> 1268315 INFO (jetty-launcher-5111-thread-2) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: ????-??-??T??:??:??-04:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 1268319 INFO (jetty-launcher-5111-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1268319 INFO (jetty-launcher-5111-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1268319 INFO (jetty-launcher-5111-thread-2) [ ] o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 1268319 INFO (jetty-launcher-5111-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5a441bac{/solr,null,AVAILABLE}
[junit4] 2> 1268326 INFO (jetty-launcher-5111-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@4086858e{SSL,[ssl, http/1.1]}{127.0.0.1:?????}
[junit4] 2> 1268326 INFO (jetty-launcher-5111-thread-1) [ ] o.e.j.s.Server Started @???????ms
[junit4] 2> 1268326 INFO (jetty-launcher-5111-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=57029}
[junit4] 2> 1268326 ERROR (jetty-launcher-5111-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1268326 INFO (jetty-launcher-5111-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.3.1
[junit4] 2> 1268326 INFO (jetty-launcher-5111-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1268326 INFO (jetty-launcher-5111-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1268326 INFO (jetty-launcher-5111-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-04-26T22:54:43.159172100Z
[junit4] 2> 1268328 INFO (jetty-launcher-5111-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@283c954a{SSL,[ssl, http/1.1]}{127.0.0.1:?????}
[junit4] 2> 1268328 INFO (jetty-launcher-5111-thread-2) [ ] o.e.j.s.Server Started @???????ms
[junit4] 2> 1268328 INFO (jetty-launcher-5111-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=57032}
[junit4] 2> 1268328 ERROR (jetty-launcher-5111-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1268329 INFO (jetty-launcher-5111-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.3.1
[junit4] 2> 1268329 INFO (jetty-launcher-5111-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1268329 INFO (jetty-launcher-5111-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1268329 INFO (jetty-launcher-5111-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-04-26T22:54:43.162210Z
[junit4] 2> 1268332 INFO (zkConnectionManagerCallback-5116-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1268332 INFO (zkConnectionManagerCallback-5118-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1268337 INFO (jetty-launcher-5111-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1268337 INFO (jetty-launcher-5111-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1268374 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 0x10002efabe40001, likely client has closed socket
[junit4] 2> 1268375 INFO (jetty-launcher-5111-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:57025/solr
[junit4] 2> 1268378 INFO (jetty-launcher-5111-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:57025/solr
[junit4] 2> 1268378 INFO (zkConnectionManagerCallback-5122-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1268385 INFO (zkConnectionManagerCallback-5126-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1268386 INFO (zkConnectionManagerCallback-5128-thread-1-processing-n:127.0.0.1:57032_solr) [n:127.0.0.1:57032_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1268386 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 0x10002efabe40004, likely client has closed socket
[junit4] 2> 1268396 INFO (zkConnectionManagerCallback-5130-thread-1-processing-n:127.0.0.1:57029_solr) [n:127.0.0.1:57029_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1268665 INFO (jetty-launcher-5111-thread-2) [n:127.0.0.1:57032_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1268666 INFO (jetty-launcher-5111-thread-2) [n:127.0.0.1:57032_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:57032_solr
[junit4] 2> 1268668 INFO (jetty-launcher-5111-thread-1) [n:127.0.0.1:57029_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1268669 INFO (jetty-launcher-5111-thread-2) [n:127.0.0.1:57032_solr ] o.a.s.c.Overseer Overseer (id=72060822442213381-127.0.0.1:57032_solr-n_0000000000) starting
[junit4] 2> 1268670 INFO (jetty-launcher-5111-thread-1) [n:127.0.0.1:57029_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:57029_solr
[junit4] 2> 1268681 INFO (zkCallback-5127-thread-1-processing-n:127.0.0.1:57032_solr) [n:127.0.0.1:57032_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1268684 INFO (zkCallback-5129-thread-1-processing-n:127.0.0.1:57029_solr) [n:127.0.0.1:57029_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1268686 INFO (zkConnectionManagerCallback-5136-thread-1-processing-n:127.0.0.1:57032_solr) [n:127.0.0.1:57032_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1268687 INFO (jetty-launcher-5111-thread-2) [n:127.0.0.1:57032_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1268698 INFO (jetty-launcher-5111-thread-2) [n:127.0.0.1:57032_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:57025/solr ready
[junit4] 2> 1268701 DEBUG (OverseerAutoScalingTriggerThread-72060822442213381-127.0.0.1:57032_solr-n_0000000000) [n:127.0.0.1:57032_solr ] o.a.s.c.a.OverseerTriggerThread Adding .autoAddReplicas trigger
[junit4] 2> 1268702 INFO (jetty-launcher-5111-thread-2) [n:127.0.0.1:57032_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:57032_solr
[junit4] 2> 1268703 DEBUG (OverseerAutoScalingTriggerThread-72060822442213381-127.0.0.1:57032_solr-n_0000000000) [n:127.0.0.1:57032_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1
[junit4] 2> 1268707 DEBUG (OverseerAutoScalingTriggerThread-72060822442213381-127.0.0.1:57032_solr-n_0000000000) [n:127.0.0.1:57032_solr ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:57029_solr]
[junit4] 2> 1268707 DEBUG (OverseerAutoScalingTriggerThread-72060822442213381-127.0.0.1:57032_solr-n_0000000000) [n:127.0.0.1:57032_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion -1
[junit4] 2> 1268707 DEBUG (OverseerAutoScalingTriggerThread-72060822442213381-127.0.0.1:57032_solr-n_0000000000) [n:127.0.0.1:57032_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
[junit4] 2> 1268710 INFO (zkCallback-5129-thread-1-processing-n:127.0.0.1:57029_solr) [n:127.0.0.1:57029_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1268710 INFO (zkCallback-5135-thread-1-processing-n:127.0.0.1:57032_solr) [n:127.0.0.1:57032_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1268710 INFO (zkCallback-5127-thread-1-processing-n:127.0.0.1:57032_solr) [n:127.0.0.1:57032_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1268712 DEBUG (OverseerAutoScalingTriggerThread-72060822442213381-127.0.0.1:57032_solr-n_0000000000) [n:127.0.0.1:57032_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
[junit4] 2> 1268712 DEBUG (OverseerAutoScalingTriggerThread-72060822442213381-127.0.0.1:57032_solr-n_0000000000) [n:127.0.0.1:57032_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
[junit4] 2> 1268713 DEBUG (ScheduledTrigger-6070-thread-1) [n:127.0.0.1:57032_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2
[junit4] 2> 1268764 INFO (jetty-launcher-5111-thread-1) [n:127.0.0.1:57029_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_57029.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@26362f3a
[junit4] 2> 1268776 INFO (jetty-launcher-5111-thread-1) [n:127.0.0.1:57029_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_57029.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@26362f3a
[junit4] 2> 1268776 INFO (jetty-launcher-5111-thread-1) [n:127.0.0.1:57029_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_57029.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@26362f3a
[junit4] 2> 1268776 INFO (jetty-launcher-5111-thread-2) [n:127.0.0.1:57032_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_57032.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@26362f3a
[junit4] 2> 1268780 INFO (jetty-launcher-5111-thread-1) [n:127.0.0.1:57029_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.TriggerIntegrationTest_A54A92EA4EF57907-001\tempDir-001\node1\.
[junit4] 2> 1268784 INFO (jetty-launcher-5111-thread-2) [n:127.0.0.1:57032_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_57032.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@26362f3a
[junit4] 2> 1268785 INFO (zkConnectionManagerCallback-5140-thread-1-processing-n:127.0.0.1:57029_solr) [n:127.0.0.1:57029_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1268785 INFO (jetty-launcher-5111-thread-2) [n:127.0.0.1:57032_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_57032.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@26362f3a
[junit4] 2> 1268786 INFO (jetty-launcher-5111-thread-1) [n:127.0.0.1:57029_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1268787 INFO (jetty-launcher-5111-thread-1) [n:127.0.0.1:57029_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:57025/solr ready
[junit4] 2> 1268787 INFO (jetty-launcher-5111-thread-2) [n:127.0.0.1:57032_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.TriggerIntegrationTest_A54A92EA4EF57907-001\tempDir-001\node2\.
[junit4] 2> 1268903 INFO (zkConnectionManagerCallback-5142-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1268910 INFO (zkConnectionManagerCallback-5146-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1268912 INFO (SUITE-TriggerIntegrationTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1268912 INFO (SUITE-TriggerIntegrationTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:57025/solr ready
[junit4] 2> 1268952 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testNodeAddedTriggerRestoreState
[junit4] 2> 1268952 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.c.a.TriggerIntegrationTest Found 2 jetty instances running
[junit4] 2> 1268957 INFO (zkConnectionManagerCallback-5148-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1269034 INFO (qtp1680783021-17177) [n:127.0.0.1:57029_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :overseerstatus with params action=OVERSEERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1269043 INFO (qtp1680783021-17177) [n:127.0.0.1:57029_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=OVERSEERSTATUS&wt=javabin&version=2} status=0 QTime=8
[junit4] 2> 1269045 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.c.a.ScheduledTriggers -- removing trigger: .auto_add_replicas
[junit4] 2> 1269047 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.c.a.TriggerIntegrationTest /autoscaling.json reset, new znode version 2
[junit4] 2> 1269048 DEBUG (zkCallback-5135-thread-1-processing-n:127.0.0.1:57032_solr) [n:127.0.0.1:57032_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 2
[junit4] 2> 1269048 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1269048 DEBUG (OverseerAutoScalingTriggerThread-72060822442213381-127.0.0.1:57032_solr-n_0000000000) [n:127.0.0.1:57032_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2
[junit4] 2> 1269049 DEBUG (OverseerAutoScalingTriggerThread-72060822442213381-127.0.0.1:57032_solr-n_0000000000) [n:127.0.0.1:57032_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers
[junit4] 2> 1269049 DEBUG (OverseerAutoScalingTriggerThread-72060822442213381-127.0.0.1:57032_solr-n_0000000000) [n:127.0.0.1:57032_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
[junit4] 2> 1269049 DEBUG (OverseerAutoScalingTriggerThread-72060822442213381-127.0.0.1:57032_solr-n_0000000000) [n:127.0.0.1:57032_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2
[junit4] 2> 1269050 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@283c954a{SSL,[ssl, http/1.1]}{127.0.0.1:?}
[junit4] 2> 1269051 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=540168204
[junit4] 2> 1269051 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1269051 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6fab6942: rootName = solr_57032, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@4b5d50c4
[junit4] 2> 1269055 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1269055 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@7054aafa: rootName = solr_57032, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@5227e391
[junit4] 2> 1269067 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1269067 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5df2553a: rootName = solr_57032, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@7ef798a9
[junit4] 2> 1269094 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:57032_solr
[junit4] 2> 1269096 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 1269096 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1269096 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.c.Overseer Overseer (id=72060822442213381-127.0.0.1:57032_solr-n_0000000000) closing
[junit4] 2> 1269099 INFO (OverseerStateUpdate-72060822442213381-127.0.0.1:57032_solr-n_0000000000) [n:127.0.0.1:57032_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:57032_solr
[junit4] 2> 1269101 WARN (OverseerAutoScalingTriggerThread-72060822442213381-127.0.0.1:57032_solr-n_0000000000) [n:127.0.0.1:57032_solr ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 1269101 DEBUG (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
[junit4] 2> 1269102 INFO (zkCallback-5127-thread-1-processing-n:127.0.0.1:57032_solr) [n:127.0.0.1:57032_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 1269102 INFO (zkCallback-5129-thread-1-processing-n:127.0.0.1:57029_solr) [n:127.0.0.1:57029_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 1269102 INFO (zkCallback-5139-thread-1-processing-n:127.0.0.1:57029_solr) [n:127.0.0.1:57029_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 1269103 INFO (zkCallback-5145-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 1269103 INFO (zkCallback-5145-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 1269103 INFO (zkCallback-5135-thread-1-processing-n:127.0.0.1:57032_solr) [n:127.0.0.1:57032_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 1269123 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 0x10002efabe40005, likely client has closed socket
[junit4] 2> 1269125 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5a441bac{/solr,null,UNAVAILABLE}
[junit4] 2> 1269125 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.e.j.s.session Stopped scavenging
[junit4] 2> 1269128 INFO (zkCallback-5129-thread-1-processing-n:127.0.0.1:57029_solr) [n:127.0.0.1:57029_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:57029_solr
[junit4] 2> 1269129 INFO (zkCallback-5129-thread-1-processing-n:127.0.0.1:57029_solr) [n:127.0.0.1:57029_solr ] o.a.s.c.Overseer Overseer (id=72060822442213382-127.0.0.1:57029_solr-n_0000000001) starting
[junit4] 2> 1269150 DEBUG (OverseerAutoScalingTriggerThread-72060822442213382-127.0.0.1:57029_solr-n_0000000001) [n:127.0.0.1:57029_solr ] o.a.s.c.a.OverseerTriggerThread Adding .autoAddReplicas trigger
[junit4] 2> 1269153 DEBUG (OverseerAutoScalingTriggerThread-72060822442213382-127.0.0.1:57029_solr-n_0000000001) [n:127.0.0.1:57029_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 3
[junit4] 2> 1269155 DEBUG (OverseerAutoScalingTriggerThread-72060822442213382-127.0.0.1:57029_solr-n_0000000001) [n:127.0.0.1:57029_solr ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:57029_solr]
[junit4] 2> 1269155 DEBUG (OverseerAutoScalingTriggerThread-72060822442213382-127.0.0.1:57029_solr-n_0000000001) [n:127.0.0.1:57029_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3, lastZnodeVersion -1
[junit4] 2> 1269155 DEBUG (OverseerAutoScalingTriggerThread-72060822442213382-127.0.0.1:57029_solr-n_0000000001) [n:127.0.0.1:57029_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 3
[junit4] 2> 1269175 DEBUG (OverseerAutoScalingTriggerThread-72060822442213382-127.0.0.1:57029_solr-n_0000000001) [n:127.0.0.1:57029_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
[junit4] 2> 1269176 DEBUG (OverseerAutoScalingTriggerThread-72060822442213382-127.0.0.1:57029_solr-n_0000000001) [n:127.0.0.1:57029_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3, lastZnodeVersion 3
[junit4] 2> 1269177 DEBUG (ScheduledTrigger-6079-thread-1) [n:127.0.0.1:57029_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
[junit4] 2> 1270179 DEBUG (ScheduledTrigger-6079-thread-1) [n:127.0.0.1:57029_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
[junit4] 2> 1271180 DEBUG (ScheduledTrigger-6079-thread-2) [n:127.0.0.1:57029_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
[junit4] 2> 1272181 DEBUG (ScheduledTrigger-6079-thread-2) [n:127.0.0.1:57029_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
[junit4] 2> 1273183 DEBUG (ScheduledTrigger-6079-thread-3) [n:127.0.0.1:57029_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
[junit4] 2> 1274128 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: ????-??-??T??:??:??-04:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 1274128 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1274128 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1274128 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 1274128 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@524f0fb1{/solr,null,AVAILABLE}
[junit4] 2> 1274142 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@642ffb39{SSL,[ssl, http/1.1]}{127.0.0.1:?????}
[junit4] 2> 1274142 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.e.j.s.Server Started @???????ms
[junit4] 2> 1274142 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=57098}
[junit4] 2> 1274143 ERROR (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1274143 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.3.1
[junit4] 2> 1274144 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1274144 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1274144 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-04-26T22:54:48.977304Z
[junit4] 2> 1274149 INFO (zkConnectionManagerCallback-5151-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1274150 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1274189 DEBUG (ScheduledTrigger-6079-thread-3) [n:127.0.0.1:57029_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1
[junit4] 2> 1274202 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:57025/solr
[junit4] 2> 1274209 INFO (zkConnectionManagerCallback-5155-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1274254 INFO (zkConnectionManagerCallback-5157-thread-1-processing-n:127.0.0.1:57098_solr) [n:127.0.0.1:57098_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1274263 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [n:127.0.0.1:57098_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1274266 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [n:127.0.0.1:57098_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1274268 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [n:127.0.0.1:57098_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:57098_solr
[junit4] 2> 1274270 INFO (zkCallback-5145-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1274270 INFO (zkCallback-5145-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1274270 INFO (zkCallback-5139-thread-1-processing-n:127.0.0.1:57029_solr) [n:127.0.0.1:57029_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1274270 INFO (zkCallback-5129-thread-1-processing-n:127.0.0.1:57029_solr) [n:127.0.0.1:57029_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1274271 INFO (zkCallback-5156-thread-1-processing-n:127.0.0.1:57098_solr) [n:127.0.0.1:57098_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1274377 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [n:127.0.0.1:57098_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_57098.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@26362f3a
[junit4] 2> 1274397 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [n:127.0.0.1:57098_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_57098.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@26362f3a
[junit4] 2> 1274398 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [n:127.0.0.1:57098_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_57098.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@26362f3a
[junit4] 2> 1274399 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [n:127.0.0.1:57098_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.TriggerIntegrationTest_A54A92EA4EF57907-001\tempDir-001\node3\.
[junit4] 2> 1274414 INFO (zkConnectionManagerCallback-5162-thread-1-processing-n:127.0.0.1:57098_solr) [n:127.0.0.1:57098_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1274417 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [n:127.0.0.1:57098_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1274421 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [n:127.0.0.1:57098_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:57025/solr ready
[junit4] 2> 1274502 INFO (qtp1680783021-17176) [n:127.0.0.1:57029_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=2
[junit4] 2> 1274538 INFO (qtp1303242523-17269) [n:127.0.0.1:57098_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=1
[junit4] 2> 1274538 DEBUG (qtp1680783021-17179) [n:127.0.0.1:57029_solr ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1274539 INFO (qtp1680783021-17179) [n:127.0.0.1:57029_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=51
[junit4] 2> 1274540 DEBUG (zkCallback-5139-thread-1-processing-n:127.0.0.1:57029_solr) [n:127.0.0.1:57029_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 4
[junit4] 2> 1274542 DEBUG (zkCallback-5139-thread-1-processing-n:127.0.0.1:57029_solr) [n:127.0.0.1:57029_solr ] o.a.s.c.a.NodeAddedTrigger Initial livenodes: [127.0.0.1:57098_solr, 127.0.0.1:57029_solr]
[junit4] 2> 1274542 DEBUG (zkCallback-5139-thread-1-processing-n:127.0.0.1:57029_solr) [n:127.0.0.1:57029_solr ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_restore_trigger instantiated with properties: {event=nodeAdded, waitFor=5, actions=[{name=test, class=org.apache.solr.cloud.autoscaling.TriggerIntegrationTest$TestTriggerAction}], enabled=true}
[junit4] 2> 1274543 DEBUG (zkCallback-5139-thread-1-processing-n:127.0.0.1:57029_solr) [n:127.0.0.1:57029_solr ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:57098_solr, 127.0.0.1:57029_solr]
[junit4] 2> 1274544 DEBUG (OverseerAutoScalingTriggerThread-72060822442213382-127.0.0.1:57029_solr-n_0000000001) [n:127.0.0.1:57029_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 4
[junit4] 2> 1274548 INFO (OverseerAutoScalingTriggerThread-72060822442213382-127.0.0.1:57029_solr-n_0000000001) [n:127.0.0.1:57029_solr ] o.a.s.c.a.TriggerIntegrationTest TestTriggerAction init
[junit4] 2> 1274549 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: ????-??-??T??:??:??-04:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 1274550 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1274550 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1274550 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 1274550 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@531a7b92{/solr,null,AVAILABLE}
[junit4] 2> 1274552 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@29981e47{SSL,[ssl, http/1.1]}{127.0.0.1:?????}
[junit4] 2> 1274552 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.e.j.s.Server Started @???????ms
[junit4] 2> 1274552 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=57115}
[junit4] 2> 1274553 ERROR (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1274553 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.3.1
[junit4] 2> 1274553 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1274553 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1274553 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-04-26T22:54:49.386067800Z
[junit4] 2> 1274554 DEBUG (ScheduledTrigger-6079-thread-2) [n:127.0.0.1:57029_solr ] o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_restore_trigger
[junit4] 2> 1274554 DEBUG (ScheduledTrigger-6079-thread-2) [n:127.0.0.1:57029_solr ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 2
[junit4] 2> 1274563 DEBUG (OverseerAutoScalingTriggerThread-72060822442213382-127.0.0.1:57029_solr-n_0000000001) [n:127.0.0.1:57029_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 4, lastZnodeVersion 4
[junit4] 2> 1274564 INFO (zkConnectionManagerCallback-5164-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1274568 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1274571 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 0x10002efabe40010, likely client has closed socket
[junit4] 2> 1274574 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:57025/solr
[junit4] 2> 1274588 INFO (zkConnectionManagerCallback-5168-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1274597 INFO (zkConnectionManagerCallback-5170-thread-1-processing-n:127.0.0.1:57115_solr) [n:127.0.0.1:57115_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1274616 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [n:127.0.0.1:57115_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1274619 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [n:127.0.0.1:57115_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1274621 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [n:127.0.0.1:57115_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:57115_solr
[junit4] 2> 1274622 INFO (zkCallback-5145-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1274622 INFO (zkCallback-5145-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1274622 INFO (zkCallback-5139-thread-1-processing-n:127.0.0.1:57029_solr) [n:127.0.0.1:57029_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1274622 INFO (zkCallback-5156-thread-1-processing-n:127.0.0.1:57098_solr) [n:127.0.0.1:57098_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1274622 INFO (zkCallback-5129-thread-1-processing-n:127.0.0.1:57029_solr) [n:127.0.0.1:57029_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1274624 INFO (zkCallback-5169-thread-1-processing-n:127.0.0.1:57115_solr) [n:127.0.0.1:57115_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1274624 INFO (zkCallback-5161-thread-1-processing-n:127.0.0.1:57098_solr) [n:127.0.0.1:57098_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1274691 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [n:127.0.0.1:57115_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_57115.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@26362f3a
[junit4] 2> 1274719 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [n:127.0.0.1:57115_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_57115.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@26362f3a
[junit4] 2> 1274720 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [n:127.0.0.1:57115_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_57115.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@26362f3a
[junit4] 2> 1274722 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [n:127.0.0.1:57115_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.TriggerIntegrationTest_A54A92EA4EF57907-001\tempDir-001\node4\.
[junit4] 2> 1274736 INFO (zkConnectionManagerCallback-5175-thread-1-processing-n:127.0.0.1:57115_solr) [n:127.0.0.1:57115_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1274737 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [n:127.0.0.1:57115_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 1274738 INFO (TEST-TriggerIntegrationTest.testNodeAddedTriggerRestoreState-seed#[A54A92EA4EF57907]) [n:127.0.0.1:57115_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:57025/solr ready
[junit4] 2> 1275191 DEBUG (ScheduledTrigger-6079-thread-4) [n:127.0.0.1:57029_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 3
[junit4] 2> 1275557 DEBUG (ScheduledTrigger-6079-thread-3) [n:127.0.0.1:57029_solr ] o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_restore_trigger
[junit4] 2> 1275557 DEBUG (ScheduledTrigger-6079-thread-3) [n:127.0.0.1:57029_solr ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
[junit4] 2> 1275557 DEBUG (Schedule
[...truncated too long message...]
2676 INFO (jetty-closer-1182-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 982676 INFO (jetty-closer-1182-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@35f5ff6e: rootName = solr_64051, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@fea995e
[junit4] 2> 982679 INFO (jetty-closer-1182-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2693f97{/solr,null,UNAVAILABLE}
[junit4] 2> 982679 INFO (jetty-closer-1182-thread-1) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:64051_solr
[junit4] 2> 982679 INFO (jetty-closer-1182-thread-2) [ ] o.e.j.s.session Stopped scavenging
[junit4] 2> 982679 INFO (jetty-closer-1182-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 982679 INFO (jetty-closer-1182-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 982680 INFO (jetty-closer-1182-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72061041553047722-127.0.0.1:64051_solr-n_0000000037) closing
[junit4] 2> 982680 INFO (zkCallback-1732-thread-1-processing-n:127.0.0.1:64051_solr) [n:127.0.0.1:64051_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
[junit4] 2> 982680 WARN (OverseerAutoScalingTriggerThread-72061041553047722-127.0.0.1:64051_solr-n_0000000037) [n:127.0.0.1:64051_solr ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 982681 DEBUG (jetty-closer-1182-thread-1) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
[junit4] 2> 982680 INFO (OverseerStateUpdate-72061041553047722-127.0.0.1:64051_solr-n_0000000037) [n:127.0.0.1:64051_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:64051_solr
[junit4] 2> 982681 INFO (zkCallback-1737-thread-1-processing-n:127.0.0.1:64051_solr) [n:127.0.0.1:64051_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
[junit4] 2> 982685 INFO (jetty-closer-1182-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@396c58e4{/solr,null,UNAVAILABLE}
[junit4] 2> 982685 INFO (jetty-closer-1182-thread-1) [ ] o.e.j.s.session Stopped scavenging
[junit4] 2> 982686 ERROR (SUITE-TriggerIntegrationTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 982687 INFO (SUITE-TriggerIntegrationTest-seed#[A54A92EA4EF57907]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:63262 63262
[junit4] 2> 982688 INFO (Thread-875) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:63262 63262
[junit4] 2> 982689 WARN (Thread-875) [ ] o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 96 /solr/aliases.json
[junit4] 2> 48 /solr/collections/collection1/terms/shard1
[junit4] 2> 40 /solr/security.json
[junit4] 2> 31 /solr/collections/testMetricTrigger/terms/shard1
[junit4] 2> 21 /solr/collections/testScheduledTrigger/terms/shard1
[junit4] 2> 9 /solr/configs/conf
[junit4] 2> 7 /solr/collections/testMetricTrigger/terms/shard2
[junit4] 2> 4 /solr/configs/testScheduledTrigger.AUTOCREATED/managed-schema
[junit4] 2> 3 /solr/configs/testScheduledTrigger.AUTOCREATED
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 96 /solr/clusterstate.json
[junit4] 2> 96 /solr/clusterprops.json
[junit4] 2> 67 /solr/collections/collection1/state.json
[junit4] 2> 63 /solr/collections/testMetricTrigger/state.json
[junit4] 2> 31 /solr/collections/testScheduledTrigger/state.json
[junit4] 2> 25 /solr/autoscaling.json
[junit4] 2> 3 /solr/overseer_elect/election/72061041553047607-127.0.0.1:63526_solr-n_0000000011
[junit4] 2> 3 /solr/overseer_elect/election/72061041553047630-127.0.0.1:63630_solr-n_0000000016
[junit4] 2> 3 /solr/overseer_elect/election/72061041553047678-127.0.0.1:63840_solr-n_0000000027
[junit4] 2> 3 /solr/overseer_elect/election/72061041553047579-127.0.0.1:63403_solr-n_0000000005
[junit4] 2> 2 /solr/overseer_elect/election/72061041553047713-127.0.0.1:64017_solr-n_0000000035
[junit4] 2> 2 /solr/collections/collection1/leader_elect/shard1/election/72061041553047682-core_node6-n_0000000002
[junit4] 2> 2 /solr/overseer_elect/election/72061041553047648-127.0.0.1:63722_solr-n_0000000020
[junit4] 2> 2 /solr/overseer_elect/election/72061041553047695-127.0.0.1:63945_solr-n_0000000031
[junit4] 2> 2 /solr/collections/collection1/leader_elect/shard1/election/72061041553047674-core_node3-n_0000000000
[junit4] 2> 2 /solr/collections/testScheduledTrigger/leader_elect/shard1/election/72061041553047579-core_node5-n_0000000001
[junit4] 2> 2 /solr/collections/testMetricTrigger/leader_elect/shard1/election/72061041553047620-core_node5-n_0000000000
[junit4] 2> 2 /solr/overseer_elect/election/72061041553047644-127.0.0.1:63707_solr-n_0000000019
[junit4] 2> 2 /solr/collections/collection1/leader_elect/shard1/election/72061041553047686-core_node4-n_0000000001
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 694 /solr/live_nodes
[junit4] 2> 139 /solr/collections
[junit4] 2> 25 /solr/overseer/queue-work
[junit4] 2> 24 /solr/overseer/collection-queue-work
[junit4] 2> 23 /solr/autoscaling/events/.auto_add_replicas
[junit4] 2> 23 /solr/overseer/queue
[junit4] 2> 2 /solr/autoscaling/events/node_lost_triggerMR
[junit4] 2> 2 /solr/autoscaling/events/node_added_triggerCTOOR
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.TriggerIntegrationTest_A54A92EA4EF57907-003
[junit4] 2> Apr 26, 2018 11:55:36 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 6 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=FastDecompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST_DECOMPRESSION, chunkSize=7, maxDocsPerChunk=876, blockSize=303), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST_DECOMPRESSION, chunkSize=7, blockSize=303)), sim=RandomSimilarity(queryNorm=false): {}, locale=nl-CW, timezone=Pacific/Fiji
[junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 9.0.4 (64-bit)/cpus=3,threads=1,free=50524568,total=202125312
[junit4] 2> NOTE: All tests run in this JVM: [SampleTest, SampleTest, TriggerIntegrationTest, SampleTest, TriggerIntegrationTest, TriggerIntegrationTest]
[junit4] Completed [10/10 (4!)] on J1 in 310.18s, 15 tests, 1 failure <<< FAILURES!
[...truncated 13 lines...]
BUILD FAILED
C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\lucene\common-build.xml:1567: The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows\lucene\common-build.xml:1091: There were test failures: 10 suites, 85 tests, 4 failures [seed: A54A92EA4EF57907]
Total time: 16 minutes 37 seconds
[repro] Setting last failure code to 1
[repro] Failures:
[repro] 0/5 failed: org.apache.solr.SampleTest
[repro] 4/5 failed: org.apache.solr.cloud.autoscaling.TriggerIntegrationTest
[repro] Exiting with code 1
C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows>IF EXIST lucene\build move /y lucene\build lucene\build.repro
1 dir(s) moved.
C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows>IF EXIST solr\build move /y solr\build solr\build.repro
1 dir(s) moved.
C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows>IF EXIST lucene\build.orig move /y lucene\build.orig lucene\build
1 dir(s) moved.
C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows>IF EXIST solr\build.orig move /y solr\build.orig solr\build
1 dir(s) moved.
C:\Users\jenkins\workspace\Lucene-Solr-7.3-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=8fa7687413558b3bc65cbbbeb722a21314187e6a, workspace=C:\Users\jenkins\workspace\Lucene-Solr-7.3-Windows
[WARNINGS] Computing warning deltas based on reference build #31
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