Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/7152/
Java: 32bit/jdk1.8.0_144 -server -XX:+UseConcMarkSweepGC
4 tests failed.
FAILED:
org.apache.lucene.replicator.IndexReplicationClientTest.testConsistencyOnExceptions
Error Message:
Captured an uncaught exception in thread: Thread[id=24,
name=ReplicationThread-index, state=RUNNABLE,
group=TGRP-IndexReplicationClientTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught
exception in thread: Thread[id=24, name=ReplicationThread-index,
state=RUNNABLE, group=TGRP-IndexReplicationClientTest]
at
__randomizedtesting.SeedInfo.seed([315194CF52D37230:BEDF736F40BF81CF]:0)
Caused by: java.lang.AssertionError: handler failed too many times: -1
at __randomizedtesting.SeedInfo.seed([315194CF52D37230]:0)
at
org.apache.lucene.replicator.IndexReplicationClientTest$4.handleUpdateException(IndexReplicationClientTest.java:304)
at
org.apache.lucene.replicator.ReplicationClient$ReplicationThread.run(ReplicationClient.java:77)
FAILED:
org.apache.solr.cloud.autoscaling.sim.TestTriggerIntegration.testNodeMarkersRegistration
Error Message:
Path /autoscaling/nodeAdded/127.0.0.1:10017_solr should have been deleted
Stack Trace:
java.lang.AssertionError: Path /autoscaling/nodeAdded/127.0.0.1:10017_solr
should have been deleted
at
__randomizedtesting.SeedInfo.seed([A2411F0DA6ABEF73:BAFB9701A89E229C]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertFalse(Assert.java:68)
at
org.apache.solr.cloud.autoscaling.sim.TestTriggerIntegration.testNodeMarkersRegistration(TestTriggerIntegration.java:844)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED: org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest.testHistory
Error Message:
expected:<5> but was:<0>
Stack Trace:
java.lang.AssertionError: expected:<5> but was:<0>
at
__randomizedtesting.SeedInfo.seed([A2411F0DA6ABEF73:CFBDBBF01CE31074]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at
org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest.testHistory(AutoscalingHistoryHandlerTest.java:244)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED:
junit.framework.TestSuite.org.apache.solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory
Error Message:
Could not remove the following files (in the order of attempts):
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1\conf:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1\conf
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1\conf\en-test-ner-person.bin:
java.nio.file.AccessDeniedException:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1\conf\en-test-ner-person.bin
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1\conf\en-test-tokenizer.bin:
java.nio.file.AccessDeniedException:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1\conf\en-test-tokenizer.bin
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1\conf\en-test-sent.bin:
java.nio.file.AccessDeniedException:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1\conf\en-test-sent.bin
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001
Stack Trace:
java.io.IOException: Could not remove the following files (in the order of
attempts):
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1\conf:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1\conf
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1\conf\en-test-ner-person.bin:
java.nio.file.AccessDeniedException:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1\conf\en-test-ner-person.bin
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1\conf\en-test-tokenizer.bin:
java.nio.file.AccessDeniedException:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1\conf\en-test-tokenizer.bin
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1\conf\en-test-sent.bin:
java.nio.file.AccessDeniedException:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1\conf\en-test-sent.bin
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001
at __randomizedtesting.SeedInfo.seed([70A3D25CF5F167EC]:0)
at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
at
org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:216)
at
com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 8888 lines...]
[junit4] Suite: org.apache.lucene.replicator.IndexReplicationClientTest
[junit4] 2> ??? 02, 2018 8:24:47 ?
com.carrotsearch.randomizedtesting.RandomizedRunner$QueueUncaughtExceptionsHandler
uncaughtException
[junit4] 2> WARNING: Uncaught exception in thread:
Thread[ReplicationThread-index,5,TGRP-IndexReplicationClientTest]
[junit4] 2> java.lang.AssertionError: handler failed too many times: -1
[junit4] 2> at
__randomizedtesting.SeedInfo.seed([315194CF52D37230]:0)
[junit4] 2> at
org.apache.lucene.replicator.IndexReplicationClientTest$4.handleUpdateException(IndexReplicationClientTest.java:304)
[junit4] 2> at
org.apache.lucene.replicator.ReplicationClient$ReplicationThread.run(ReplicationClient.java:77)
[junit4] 2>
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=IndexReplicationClientTest
-Dtests.method=testConsistencyOnExceptions -Dtests.seed=315194CF52D37230
-Dtests.slow=true -Dtests.locale=ar-LY -Dtests.timezone=America/El_Salvador
-Dtests.asserts=true -Dtests.file.encoding=Cp1252
[junit4] ERROR 2.47s J1 |
IndexReplicationClientTest.testConsistencyOnExceptions <<<
[junit4] > Throwable #1:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught
exception in thread: Thread[id=24, name=ReplicationThread-index,
state=RUNNABLE, group=TGRP-IndexReplicationClientTest]
[junit4] > at
__randomizedtesting.SeedInfo.seed([315194CF52D37230:BEDF736F40BF81CF]:0)
[junit4] > Caused by: java.lang.AssertionError: handler failed too many
times: -1
[junit4] > at
__randomizedtesting.SeedInfo.seed([315194CF52D37230]:0)
[junit4] > at
org.apache.lucene.replicator.IndexReplicationClientTest$4.handleUpdateException(IndexReplicationClientTest.java:304)
[junit4] > at
org.apache.lucene.replicator.ReplicationClient$ReplicationThread.run(ReplicationClient.java:77)
[junit4] 2> NOTE: test params are: codec=Lucene70,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@a6853b),
locale=ar-LY, timezone=America/El_Salvador
[junit4] 2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_144
(32-bit)/cpus=3,threads=1,free=43968944,total=64880640
[junit4] 2> NOTE: All tests run in this JVM: [TestNRTReplication,
IndexRevisionTest, IndexAndTaxonomyRevisionTest, IndexReplicationClientTest]
[junit4] Completed [6/9 (1!)] on J1 in 3.06s, 4 tests, 1 error <<< FAILURES!
[...truncated 3263 lines...]
[junit4] Suite: org.apache.solr.cloud.autoscaling.sim.TestTriggerIntegration
[junit4] 2> 1189326 INFO
(SUITE-TestTriggerIntegration-seed#[A2411F0DA6ABEF73]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.autoscaling.sim.TestTriggerIntegration_A2411F0DA6ABEF73-001\init-core-data-001
[junit4] 2> 1189329 WARN
(SUITE-TestTriggerIntegration-seed#[A2411F0DA6ABEF73]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=31 numCloses=31
[junit4] 2> 1189329 INFO
(SUITE-TestTriggerIntegration-seed#[A2411F0DA6ABEF73]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 1189335 INFO
(SUITE-TestTriggerIntegration-seed#[A2411F0DA6ABEF73]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 1189337 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Adding .autoAddReplicas trigger
[junit4] 2> 1189338 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode
version 0
[junit4] 2> 1189338 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.SolrTestCaseJ4 ###Starting testTriggerThrottling
[junit4] 2> 1189338 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10006_solr,
127.0.0.1:10005_solr]
[junit4] 2> 1189338 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 0, lastZnodeVersion -1
[junit4] 2> 1189338 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 0
[junit4] 2> 1189338 DEBUG
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode
version 1
[junit4] 2> 1189338 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimCloudManager === Restarting OverseerTriggerThread and
clearing object cache...
[junit4] 2> 1189338 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
[junit4] 2> 1189340 WARN (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Interrupted
[junit4] 2> java.lang.InterruptedException
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireInterruptibly(AbstractQueuedSynchronizer.java:1220)
[junit4] 2> at
java.util.concurrent.locks.ReentrantLock.lockInterruptibly(ReentrantLock.java:335)
[junit4] 2> at
org.apache.solr.cloud.autoscaling.OverseerTriggerThread.run(OverseerTriggerThread.java:154)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 1189340 DEBUG (ScheduledTrigger-3510-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2
[junit4] 2> 1189340 DEBUG
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed
explicitly
[junit4] 2> 1189341 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Adding .autoAddReplicas trigger
[junit4] 2> 1189341 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode
version 2
[junit4] 2> 1189341 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10006_solr,
127.0.0.1:10005_solr]
[junit4] 2> 1189341 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion -1
[junit4] 2> 1189341 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2
[junit4] 2> 1189342 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
[junit4] 2> 1189342 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2
[junit4] 2> 1189350 DEBUG (ScheduledTrigger-3513-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2
[junit4] 2> 1189372 DEBUG (ScheduledTrigger-3513-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2
[junit4] 2> 1189410 DEBUG (ScheduledTrigger-3513-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2
[junit4] 2> 1189441 DEBUG (ScheduledTrigger-3513-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2
[junit4] 2> 1189442 DEBUG (simCloudManagerPool-3512-thread-1) [ ]
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1189442 DEBUG (simCloudManagerPool-3512-thread-1) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
3
[junit4] 2> 1189497 DEBUG (simCloudManagerPool-3512-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10006_solr,
127.0.0.1:10005_solr]
[junit4] 2> 1189497 DEBUG (simCloudManagerPool-3512-thread-1) [ ]
o.a.s.c.a.NodeAddedTrigger Initial livenodes: [127.0.0.1:10006_solr,
127.0.0.1:10005_solr]
[junit4] 2> 1189497 DEBUG (simCloudManagerPool-3512-thread-1) [ ]
o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger1 instantiated
with properties: {event=nodeAdded, waitFor=0, actions=[{name=test,
class=org.apache.solr.cloud.autoscaling.sim.TestTriggerIntegration$ThrottlingTesterAction}],
enabled=true}
[junit4] 2> 1189497 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 3
[junit4] 2> 1189497 INFO (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.s.TestTriggerIntegration TestTriggerAction init
[junit4] 2> 1189497 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3, lastZnodeVersion 3
[junit4] 2> 1189506 DEBUG (ScheduledTrigger-3513-thread-3) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2
[junit4] 2> 1189506 DEBUG (ScheduledTrigger-3513-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger1
[junit4] 2> 1189506 DEBUG (ScheduledTrigger-3513-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 2
[junit4] 2> 1189525 DEBUG (simCloudManagerPool-3512-thread-2) [ ]
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1189525 DEBUG (simCloudManagerPool-3512-thread-2) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
4
[junit4] 2> 1189525 DEBUG (simCloudManagerPool-3512-thread-2) [ ]
o.a.s.c.a.NodeAddedTrigger Initial livenodes: [127.0.0.1:10006_solr,
127.0.0.1:10005_solr]
[junit4] 2> 1189525 DEBUG (simCloudManagerPool-3512-thread-2) [ ]
o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger2 instantiated
with properties: {event=nodeAdded, waitFor=0, actions=[{name=test,
class=org.apache.solr.cloud.autoscaling.sim.TestTriggerIntegration$ThrottlingTesterAction}],
enabled=true}
[junit4] 2> 1189525 DEBUG (simCloudManagerPool-3512-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10006_solr,
127.0.0.1:10005_solr]
[junit4] 2> 1189534 DEBUG (simCloudManagerPool-3512-thread-2) [ ]
o.a.s.c.a.NodeAddedTrigger Initial livenodes: [127.0.0.1:10006_solr,
127.0.0.1:10005_solr]
[junit4] 2> 1189535 DEBUG (simCloudManagerPool-3512-thread-2) [ ]
o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger1 instantiated
with properties: {event=nodeAdded, waitFor=0, actions=[{name=test,
class=org.apache.solr.cloud.autoscaling.sim.TestTriggerIntegration$ThrottlingTesterAction}],
enabled=true}
[junit4] 2> 1189535 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 4
[junit4] 2> 1189535 INFO (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.s.TestTriggerIntegration TestTriggerAction init
[junit4] 2> 1189535 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 4, lastZnodeVersion 4
[junit4] 2> 1189559 DEBUG (ScheduledTrigger-3513-thread-4) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger2
[junit4] 2> 1189559 DEBUG (ScheduledTrigger-3513-thread-4) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
[junit4] 2> 1189559 DEBUG (ScheduledTrigger-3513-thread-4) [ ]
o.a.s.c.a.NodeAddedTrigger Tracking new node: 127.0.0.1:10007_solr at time
1137979037616719
[junit4] 2> 1189559 DEBUG (ScheduledTrigger-3513-thread-4) [ ]
o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger2 firing
registered processor for nodes: [127.0.0.1:10007_solr] added at times
[1137979037616719], now=1137979045822869
[junit4] 2> 1189559 DEBUG (ScheduledTrigger-3513-thread-4) [ ]
o.a.s.c.a.ScheduledTriggers ++++++++ Cooldown inactive - processing event: {
[junit4] 2> "id":"40afc644c8a4fTeg9tkrd1ab03j9y9y0fv9sjkr",
[junit4] 2> "source":"node_added_trigger2",
[junit4] 2> "eventTime":1137979037616719,
[junit4] 2> "eventType":"NODEADDED",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[1137979037616719],
[junit4] 2> "nodeNames":["127.0.0.1:10007_solr"]}}
[junit4] 2> 1189560 DEBUG (ScheduledTrigger-3513-thread-4) [ ]
o.a.s.c.a.ScheduledTriggers Pausing all triggers: [.auto_add_replicas,
node_added_trigger2, node_added_trigger1]
[junit4] 2> 1189561 DEBUG (ScheduledTrigger-3513-thread-2) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger1
[junit4] 2> 1189561 DEBUG (ScheduledTrigger-3513-thread-2) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
[junit4] 2> 1189561 DEBUG (ScheduledTrigger-3513-thread-2) [ ]
o.a.s.c.a.NodeAddedTrigger Tracking new node: 127.0.0.1:10007_solr at time
1137979168943869
[junit4] 2> 1189561 DEBUG (ScheduledTrigger-3513-thread-2) [ ]
o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger1 firing
registered processor for nodes: [127.0.0.1:10007_solr] added at times
[1137979168943869], now=1137979171475419
[junit4] 2> 1189561 DEBUG (ScheduledTrigger-3513-thread-2) [ ]
o.a.s.c.a.ScheduledTriggers ++++++++ Cooldown inactive - processing event: {
[junit4] 2> "id":"40afc6c206efdTeg9tkrd1ab03j9y9y0fv9sjkt",
[junit4] 2> "source":"node_added_trigger1",
[junit4] 2> "eventTime":1137979168943869,
[junit4] 2> "eventType":"NODEADDED",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[1137979168943869],
[junit4] 2> "nodeNames":["127.0.0.1:10007_solr"]}}
[junit4] 2> 1189566 DEBUG (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers -- processing actions for {
[junit4] 2> "id":"40afc644c8a4fTeg9tkrd1ab03j9y9y0fv9sjkr",
[junit4] 2> "source":"node_added_trigger2",
[junit4] 2> "eventTime":1137979037616719,
[junit4] 2> "eventType":"NODEADDED",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[1137979037616719],
[junit4] 2> "_enqueue_time_":1137979136759169,
[junit4] 2> "nodeNames":["127.0.0.1:10007_solr"]}}
[junit4] 2> 1189566 INFO (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.s.TestTriggerIntegration action executed from node_added_trigger2
[junit4] 2> 1189567 DEBUG (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers Resuming trigger: .auto_add_replicas after 100ms
[junit4] 2> 1189567 DEBUG (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers Resuming trigger: node_added_trigger2 after 100ms
[junit4] 2> 1189567 DEBUG (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers Resuming trigger: node_added_trigger1 after 100ms
[junit4] 2> 1189567 DEBUG (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers -- processing took 106 ms for event
id=40afc644c8a4fTeg9tkrd1ab03j9y9y0fv9sjkr
[junit4] 2> 1189670 DEBUG (ScheduledTrigger-3513-thread-4) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger1
[junit4] 2> 1189670 DEBUG (ScheduledTrigger-3513-thread-1) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger2
[junit4] 2> 1189670 DEBUG (ScheduledTrigger-3513-thread-3) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 3
[junit4] 2> 1189670 DEBUG (ScheduledTrigger-3513-thread-1) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
[junit4] 2> 1189670 DEBUG (ScheduledTrigger-3513-thread-4) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
[junit4] 2> 1189670 DEBUG (ScheduledTrigger-3513-thread-4) [ ]
o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger1 firing
registered processor for nodes: [127.0.0.1:10007_solr] added at times
[1137979168943869], now=1137984628067069
[junit4] 2> 1189670 DEBUG (ScheduledTrigger-3513-thread-4) [ ]
o.a.s.c.a.ScheduledTriggers ++++++++ Cooldown inactive - processing event: {
[junit4] 2> "id":"40afc6c206efdTeg9tkrd1ab03j9y9y0fv9sjkw",
[junit4] 2> "source":"node_added_trigger1",
[junit4] 2> "eventTime":1137979168943869,
[junit4] 2> "eventType":"NODEADDED",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[1137979168943869],
[junit4] 2> "nodeNames":["127.0.0.1:10007_solr"]}}
[junit4] 2> 1189671 DEBUG (ScheduledTrigger-3513-thread-4) [ ]
o.a.s.c.a.ScheduledTriggers Pausing all triggers: [.auto_add_replicas,
node_added_trigger2, node_added_trigger1]
[junit4] 2> 1189671 DEBUG (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers -- processing actions for {
[junit4] 2> "id":"40afc6c206efdTeg9tkrd1ab03j9y9y0fv9sjkw",
[junit4] 2> "source":"node_added_trigger1",
[junit4] 2> "eventTime":1137979168943869,
[junit4] 2> "eventType":"NODEADDED",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[1137979168943869],
[junit4] 2> "_enqueue_time_":1137984638605669,
[junit4] 2> "nodeNames":["127.0.0.1:10007_solr"]}}
[junit4] 2> 1189672 INFO (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.s.TestTriggerIntegration last action at 1137979423591169 time =
1137984683163619
[junit4] 2> 1189672 INFO (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.s.TestTriggerIntegration action executed from node_added_trigger1
[junit4] 2> 1189674 DEBUG (simCloudManagerPool-3512-thread-7) [ ]
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1189674 DEBUG (simCloudManagerPool-3512-thread-7) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
5
[junit4] 2> 1189674 DEBUG (simCloudManagerPool-3512-thread-7) [ ]
o.a.s.c.a.NodeAddedTrigger Initial livenodes: [127.0.0.1:10006_solr,
127.0.0.1:10005_solr, 127.0.0.1:10007_solr]
[junit4] 2> 1189674 DEBUG (simCloudManagerPool-3512-thread-7) [ ]
o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger2 instantiated
with properties: {event=nodeAdded, waitFor=0, actions=[{name=test,
class=org.apache.solr.cloud.autoscaling.sim.TestTriggerIntegration$ThrottlingTesterAction}],
enabled=true}
[junit4] 2> 1189674 DEBUG (simCloudManagerPool-3512-thread-7) [ ]
o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10006_solr,
127.0.0.1:10005_solr, 127.0.0.1:10007_solr]
[junit4] 2> 1189674 DEBUG (simCloudManagerPool-3512-thread-7) [ ]
o.a.s.c.a.NodeAddedTrigger Initial livenodes: [127.0.0.1:10006_solr,
127.0.0.1:10005_solr, 127.0.0.1:10007_solr]
[junit4] 2> 1189674 DEBUG (simCloudManagerPool-3512-thread-7) [ ]
o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger1 instantiated
with properties: {event=nodeAdded, waitFor=0, actions=[{name=test,
class=org.apache.solr.cloud.autoscaling.sim.TestTriggerIntegration$ThrottlingTesterAction}],
enabled=true}
[junit4] 2> 1189674 DEBUG (simCloudManagerPool-3512-thread-7) [ ]
o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10006_solr,
127.0.0.1:10005_solr, 127.0.0.1:10007_solr]
[junit4] 2> 1189674 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 5
[junit4] 2> 1189675 DEBUG (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers Resuming trigger: .auto_add_replicas after 100ms
[junit4] 2> 1189675 DEBUG (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers Resuming trigger: node_added_trigger2 after 100ms
[junit4] 2> 1189675 DEBUG (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers Resuming trigger: node_added_trigger1 after 100ms
[junit4] 2> 1189675 DEBUG (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers -- processing took 157 ms for event
id=40afc6c206efdTeg9tkrd1ab03j9y9y0fv9sjkw
[junit4] 2> 1189675 INFO (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.s.TestTriggerIntegration TestTriggerAction init
[junit4] 2> 1189675 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 5, lastZnodeVersion 5
[junit4] 2> 1189675 DEBUG (ScheduledTrigger-3513-thread-3) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: node_lost_trigger1 with
currently live nodes: 3
[junit4] 2> 1189676 DEBUG (simCloudManagerPool-3512-thread-9) [ ]
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1189676 DEBUG (simCloudManagerPool-3512-thread-9) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
6
[junit4] 2> 1189676 DEBUG (simCloudManagerPool-3512-thread-9) [ ]
o.a.s.c.a.NodeAddedTrigger Initial livenodes: [127.0.0.1:10006_solr,
127.0.0.1:10005_solr, 127.0.0.1:10007_solr]
[junit4] 2> 1189676 DEBUG (simCloudManagerPool-3512-thread-9) [ ]
o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger2 instantiated
with properties: {event=nodeAdded, waitFor=0, actions=[{name=test,
class=org.apache.solr.cloud.autoscaling.sim.TestTriggerIntegration$ThrottlingTesterAction}],
enabled=true}
[junit4] 2> 1189676 DEBUG (simCloudManagerPool-3512-thread-9) [ ]
o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10006_solr,
127.0.0.1:10005_solr, 127.0.0.1:10007_solr]
[junit4] 2> 1189676 DEBUG (simCloudManagerPool-3512-thread-9) [ ]
o.a.s.c.a.NodeAddedTrigger Initial livenodes: [127.0.0.1:10006_solr,
127.0.0.1:10005_solr, 127.0.0.1:10007_solr]
[junit4] 2> 1189676 DEBUG (simCloudManagerPool-3512-thread-9) [ ]
o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger1 instantiated
with properties: {event=nodeAdded, waitFor=0, actions=[{name=test,
class=org.apache.solr.cloud.autoscaling.sim.TestTriggerIntegration$ThrottlingTesterAction}],
enabled=true}
[junit4] 2> 1189677 DEBUG (simCloudManagerPool-3512-thread-9) [ ]
o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10006_solr,
127.0.0.1:10005_solr, 127.0.0.1:10007_solr]
[junit4] 2> 1189677 DEBUG (simCloudManagerPool-3512-thread-9) [ ]
o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10006_solr,
127.0.0.1:10005_solr, 127.0.0.1:10007_solr]
[junit4] 2> 1189677 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 6
[junit4] 2> 1189677 INFO (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.s.TestTriggerIntegration TestTriggerAction init
[junit4] 2> 1189677 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 6, lastZnodeVersion 6
[junit4] 2> 1189677 DEBUG (ScheduledTrigger-3513-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: node_lost_trigger2 with
currently live nodes: 3
[junit4] 2> 1189697 DEBUG (ScheduledTrigger-3513-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: node_lost_trigger1 with
currently live nodes: 2
[junit4] 2> 1189697 DEBUG (ScheduledTrigger-3513-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Tracking lost node: 127.0.0.1:10007_solr
[junit4] 2> 1189697 DEBUG (ScheduledTrigger-3513-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger NodeLostTrigger firing registered processor for lost
nodes: [127.0.0.1:10007_solr]
[junit4] 2> 1189697 DEBUG (ScheduledTrigger-3513-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers ++++++++ Cooldown inactive - processing event: {
[junit4] 2> "id":"40afdffb011e5Teg9tkrd1ab03j9y9y0fv9sjkz",
[junit4] 2> "source":"node_lost_trigger1",
[junit4] 2> "eventTime":1137985939575269,
[junit4] 2> "eventType":"NODELOST",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[1137985939575269],
[junit4] 2> "nodeNames":["127.0.0.1:10007_solr"]}}
[junit4] 2> 1189697 DEBUG (ScheduledTrigger-3513-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers Pausing all triggers: [node_lost_trigger2,
.auto_add_replicas, node_added_trigger2, node_lost_trigger1,
node_added_trigger1]
[junit4] 2> 1189700 DEBUG (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers -- processing actions for {
[junit4] 2> "id":"40afdffb011e5Teg9tkrd1ab03j9y9y0fv9sjkz",
[junit4] 2> "source":"node_lost_trigger1",
[junit4] 2> "eventTime":1137985939575269,
[junit4] 2> "eventType":"NODELOST",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[1137985939575269],
[junit4] 2> "_enqueue_time_":1137985953925419,
[junit4] 2> "nodeNames":["127.0.0.1:10007_solr"]}}
[junit4] 2> 1189700 INFO (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.s.TestTriggerIntegration action executed from node_lost_trigger1
[junit4] 2> 1189701 DEBUG (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers Resuming trigger: node_lost_trigger2 after 100ms
[junit4] 2> 1189701 DEBUG (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers Resuming trigger: .auto_add_replicas after 100ms
[junit4] 2> 1189701 DEBUG (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers Resuming trigger: node_added_trigger2 after 100ms
[junit4] 2> 1189701 DEBUG (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers Resuming trigger: node_lost_trigger1 after 100ms
[junit4] 2> 1189701 DEBUG (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers Resuming trigger: node_added_trigger1 after 100ms
[junit4] 2> 1189701 DEBUG (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers -- processing took 78 ms for event
id=40afdffb011e5Teg9tkrd1ab03j9y9y0fv9sjkz
[junit4] 2> 1189808 DEBUG (ScheduledTrigger-3513-thread-3) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2
[junit4] 2> 1189808 DEBUG (ScheduledTrigger-3513-thread-2) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger2
[junit4] 2> 1189808 DEBUG (ScheduledTrigger-3513-thread-3) [ ]
o.a.s.c.a.NodeLostTrigger Tracking lost node: 127.0.0.1:10007_solr
[junit4] 2> 1189808 DEBUG (ScheduledTrigger-3513-thread-2) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 2
[junit4] 2> 1189808 DEBUG (ScheduledTrigger-3513-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: node_lost_trigger1 with
currently live nodes: 2
[junit4] 2> 1189808 DEBUG (ScheduledTrigger-3513-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger1
[junit4] 2> 1189808 DEBUG (ScheduledTrigger-3513-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 2
[junit4] 2> 1189808 DEBUG (ScheduledTrigger-3513-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: node_lost_trigger2 with
currently live nodes: 2
[junit4] 2> 1189808 DEBUG (ScheduledTrigger-3513-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger Tracking lost node: 127.0.0.1:10007_solr
[junit4] 2> 1189808 DEBUG (ScheduledTrigger-3513-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger NodeLostTrigger firing registered processor for lost
nodes: [127.0.0.1:10007_solr]
[junit4] 2> 1189808 DEBUG (ScheduledTrigger-3513-thread-4) [ ]
o.a.s.c.a.ScheduledTriggers ++++++++ Cooldown inactive - processing event: {
[junit4] 2> "id":"40aff51dce127Teg9tkrd1ab03j9y9y0fv9sjl2",
[junit4] 2> "source":"node_lost_trigger2",
[junit4] 2> "eventTime":1137991613210919,
[junit4] 2> "eventType":"NODELOST",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[1137991613210919],
[junit4] 2> "nodeNames":["127.0.0.1:10007_solr"]}}
[junit4] 2> 1189808 DEBUG (ScheduledTrigger-3513-thread-4) [ ]
o.a.s.c.a.ScheduledTriggers Pausing all triggers: [node_lost_trigger2,
.auto_add_replicas, node_added_trigger2, node_lost_trigger1,
node_added_trigger1]
[junit4] 2> 1189812 DEBUG (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers -- processing actions for {
[junit4] 2> "id":"40aff51dce127Teg9tkrd1ab03j9y9y0fv9sjl2",
[junit4] 2> "source":"node_lost_trigger2",
[junit4] 2> "eventTime":1137991613210919,
[junit4] 2> "eventType":"NODELOST",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[1137991613210919],
[junit4] 2> "_enqueue_time_":1137991625683719,
[junit4] 2> "nodeNames":["127.0.0.1:10007_solr"]}}
[junit4] 2> 1189812 INFO (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.s.TestTriggerIntegration last action at 1137986104480919 time =
1137991723076869
[junit4] 2> 1189812 INFO (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.s.TestTriggerIntegration action executed from node_lost_trigger2
[junit4] 2> 1189814 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.SolrTestCaseJ4 ###Ending testTriggerThrottling
[junit4] 2> 1189814 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimSolrCloudTestCase
[junit4] 2>
[junit4] 2> 1189814 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimSolrCloudTestCase
#############################################
[junit4] 2> 1189814 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimSolrCloudTestCase ############ FINAL CLUSTER STATS
############
[junit4] 2> 1189814 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimSolrCloudTestCase
#############################################
[junit4] 2>
[junit4] 2> 1189814 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimSolrCloudTestCase ## Live nodes: 2
[junit4] 2> 1189814 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimSolrCloudTestCase ## Empty nodes: 2
[junit4] 2> 1189814 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimSolrCloudTestCase ## Dead nodes: 1
[junit4] 2> 1189814 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimSolrCloudTestCase ## 127.0.0.1:10007_solr
[junit4] 2> 1189815 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimSolrCloudTestCase ## Collections: []
[junit4] 2> 1189815 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimSolrCloudTestCase ## Max replicas per node: 0
[junit4] 2> 1189815 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimSolrCloudTestCase ## Min replicas per node: 0
[junit4] 2> 1189815 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimSolrCloudTestCase ## Total replicas: 0
[junit4] 2> 1189815 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimSolrCloudTestCase ######### Final Solr op counts ##########
[junit4] 2> 1189815 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimSolrCloudTestCase ## - autoscaling 4
[junit4] 2> 1189815 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimSolrCloudTestCase ## - update 8
[junit4] 2> 1189815 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimSolrCloudTestCase ######### Autoscaling event counts
###########
[junit4] 2> 1189815 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimSolrCloudTestCase ## * Trigger: node_added_trigger1
[junit4] 2> 1189816 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimSolrCloudTestCase ## - IGNORED 1
[junit4] 2> 1189816 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimSolrCloudTestCase ## - STARTED 1
[junit4] 2> 1189816 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimSolrCloudTestCase ## - SUCCEEDED 1
[junit4] 2> 1189816 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimSolrCloudTestCase ## * Trigger: node_added_trigger2
[junit4] 2> 1189816 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimSolrCloudTestCase ## - STARTED 1
[junit4] 2> 1189816 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimSolrCloudTestCase ## - SUCCEEDED 1
[junit4] 2> 1189816 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimSolrCloudTestCase ## * Trigger: node_lost_trigger1
[junit4] 2> 1189816 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimSolrCloudTestCase ## - STARTED 1
[junit4] 2> 1189816 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimSolrCloudTestCase ## - SUCCEEDED 1
[junit4] 2> 1189816 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimSolrCloudTestCase ## * Trigger: node_lost_trigger2
[junit4] 2> 1189816 INFO
(TEST-TestTriggerIntegration.testTriggerThrottling-seed#[A2411F0DA6ABEF73]) [
] o.a.s.c.a.s.SimSolrCloudTestCase ## - STARTED 1
[junit4] 2> 1189840 DEBUG (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers Resuming trigger: node_lost_trigger2 after 100ms
[junit4] 2> 1189840 DEBUG (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers Resuming trigger: .auto_add_replicas after 100ms
[junit4] 2> 1189840 DEBUG (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers Resuming trigger: node_added_trigger2 after 100ms
[junit4] 2> 1189840 DEBUG (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers Resuming trigger: node_lost_trigger1 after 100ms
[junit4] 2> 1189840 DEBUG (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers Resuming trigger: node_added_trigger1 after 100ms
[junit4] 2> 1189840 DEBUG (AutoscalingActionExecutor-3514-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers -- processing took 1461 ms for event
id=40aff51dce127Teg9tkrd1ab03j9y9y0fv9sjl2
[junit4] 2> 1189843 INFO
(TEST-TestTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testNodeAddedTriggerRestoreState
[junit4] 2> 1189843 DEBUG
(TEST-TestTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode
version 7
[junit4] 2> 1189843 DEBUG
(TEST-TestTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimNodeStateProvider - removing dead node values:
127.0.0.1:10007_solr
[junit4] 2> 1189843 INFO
(TEST-TestTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimCloudManager === Restarting OverseerTriggerThread and
clearing object cache...
[junit4] 2> 1189844 DEBUG
(TEST-TestTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed
explicitly
[junit4] 2> 1189844 WARN (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are
closed, exiting.
[junit4] 2> 1189846 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Adding .autoAddReplicas trigger
[junit4] 2> 1189847 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode
version 8
[junit4] 2> 1189847 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10006_solr,
127.0.0.1:10005_solr]
[junit4] 2> 1189847 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 8, lastZnodeVersion -1
[junit4] 2> 1189847 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 8
[junit4] 2> 1189847 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
[junit4] 2> 1189847 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 8, lastZnodeVersion 8
[junit4] 2> 1189847 DEBUG (ScheduledTrigger-3516-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2
[junit4] 2> 1189886 DEBUG (ScheduledTrigger-3516-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2
[junit4] 2> 1189921 DEBUG (ScheduledTrigger-3516-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2
[junit4] 2> 1189956 DEBUG (ScheduledTrigger-3516-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2
[junit4] 2> 1189958 DEBUG (simCloudManagerPool-3515-thread-1) [ ]
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1189958 DEBUG (simCloudManagerPool-3515-thread-1) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
9
[junit4] 2> 1189958 DEBUG (simCloudManagerPool-3515-thread-1) [ ]
o.a.s.c.a.NodeAddedTrigger Initial livenodes: [127.0.0.1:10006_solr,
127.0.0.1:10005_solr]
[junit4] 2> 1189958 DEBUG (simCloudManagerPool-3515-thread-1) [ ]
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.sim.TestTriggerIntegration$TestTriggerAction}],
enabled=true}
[junit4] 2> 1189958 DEBUG (simCloudManagerPool-3515-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10006_solr,
127.0.0.1:10005_solr]
[junit4] 2> 1189958 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 9
[junit4] 2> 1189959 INFO (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.s.TestTriggerIntegration TestTriggerAction init
[junit4] 2> 1189959 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 9, lastZnodeVersion 9
[junit4] 2> 1189959 DEBUG (ScheduledTrigger-3516-thread-1) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_restore_trigger
[junit4] 2> 1189959 DEBUG (ScheduledTrigger-3516-thread-1) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 2
[junit4] 2> 1189979 DEBUG (ScheduledTrigger-3516-thread-3) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 3
[junit4] 2> 1189981 DEBUG (ScheduledTrigger-3516-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_restore_trigger
[junit4] 2> 1189981 DEBUG (ScheduledTrigger-3516-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
[junit4] 2> 1189981 DEBUG (ScheduledTrigger-3516-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Tracking new node: 127.0.0.1:10008_solr at time
1138000172773319
[junit4] 2> 1189990 DEBUG (simCloudManagerPool-3515-thread-2) [ ]
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1189990 DEBUG (simCloudManagerPool-3515-thread-2) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
10
[junit4] 2> 1189990 DEBUG (simCloudManagerPool-3515-thread-2) [ ]
o.a.s.c.a.NodeAddedTrigger Initial livenodes: [127.0.0.1:10006_solr,
127.0.0.1:10005_solr, 127.0.0.1:10008_solr]
[junit4] 2> 1189990 DEBUG (simCloudManagerPool-3515-thread-2) [ ]
o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_restore_trigger
instantiated with properties: {event=nodeAdded, waitFor=0, actions=[{name=test,
class=org.apache.solr.cloud.autoscaling.sim.TestTriggerIntegration$TestTriggerAction}],
enabled=true}
[junit4] 2> 1189990 DEBUG (simCloudManagerPool-3515-thread-2) [ ]
o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10006_solr,
127.0.0.1:10005_solr, 127.0.0.1:10008_solr]
[junit4] 2> 1189990 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion
10
[junit4] 2> 1189990 INFO (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.s.TestTriggerIntegration TestTriggerAction init
[junit4] 2> 1189990 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.NodeAddedTrigger Adding node from marker path: 127.0.0.1:10008_solr
[junit4] 2> 1189990 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 10, lastZnodeVersion 10
[junit4] 2> 1189990 DEBUG (ScheduledTrigger-3516-thread-2) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_restore_trigger
[junit4] 2> 1189990 DEBUG (ScheduledTrigger-3516-thread-2) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
[junit4] 2> 1189990 DEBUG (ScheduledTrigger-3516-thread-2) [ ]
o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_restore_trigger firing
registered processor for nodes: [127.0.0.1:10008_solr] added at times
[1138000701538019], now=1138000708762869
[junit4] 2> 1189990 DEBUG (ScheduledTrigger-3516-thread-2) [ ]
o.a.s.c.a.ScheduledTriggers ++++++++ Cooldown inactive - processing event: {
[junit4] 2> "id":"40b016f91bee3Teg9tkrd1ab03j9y9y0fv9sjl5",
[junit4] 2> "source":"node_added_restore_trigger",
[junit4] 2> "eventTime":1138000701538019,
[junit4] 2> "eventType":"NODEADDED",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[1138000701538019],
[junit4] 2> "nodeNames":["127.0.0.1:10008_solr"]}}
[junit4] 2> 1189999 DEBUG (ScheduledTrigger-3516-thread-2) [ ]
o.a.s.c.a.ScheduledTriggers Pausing all triggers: [.auto_add_replicas,
node_added_restore_trigger]
[junit4] 2> 1190001 DEBUG (AutoscalingActionExecutor-3517-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers -- processing actions for {
[junit4] 2> "id":"40b016f91bee3Teg9tkrd1ab03j9y9y0fv9sjl5",
[junit4] 2> "source":"node_added_restore_trigger",
[junit4] 2> "eventTime":1138000701538019,
[junit4] 2> "eventType":"NODEADDED",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[1138000701538019],
[junit4] 2> "_enqueue_time_":1138001077898319,
[junit4] 2> "nodeNames":["127.0.0.1:10008_solr"]}}
[junit4] 2> 1190001 INFO
(TEST-TestTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testNodeAddedTriggerRestoreState
[junit4] 2> 1190001 INFO
(TEST-TestTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase
[junit4] 2>
[junit4] 2> 1190001 INFO
(TEST-TestTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase
#############################################
[junit4] 2> 1190001 INFO
(TEST-TestTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ############ FINAL CLUSTER STATS
############
[junit4] 2> 1190001 INFO
(TEST-TestTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase
#############################################
[junit4] 2>
[junit4] 2> 1190001 INFO
(TEST-TestTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ## Live nodes: 3
[junit4] 2> 1190001 INFO
(TEST-TestTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ## Empty nodes: 3
[junit4] 2> 1190001 INFO
(TEST-TestTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ## Dead nodes: 0
[junit4] 2> 1190001 INFO
(TEST-TestTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ## Collections: []
[junit4] 2> 1190001 INFO
(TEST-TestTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ## Max replicas per node: 0
[junit4] 2> 1190001 INFO
(TEST-TestTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ## Min replicas per node: 0
[junit4] 2> 1190001 INFO
(TEST-TestTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ## Total replicas: 0
[junit4] 2> 1190001 INFO
(TEST-TestTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ######### Final Solr op counts
##########
[junit4] 2> 1190002 INFO
(TEST-TestTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ## - autoscaling
2
[junit4] 2> 1190002 INFO
(TEST-TestTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ## - update
1
[junit4] 2> 1190002 INFO
(TEST-TestTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ######### Autoscaling event counts
###########
[junit4] 2> 1190002 INFO
(TEST-TestTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ## * Trigger:
node_added_restore_trigger
[junit4] 2> 1190002 INFO
(TEST-TestTriggerIntegration.testNodeAddedTriggerRestoreState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ## - STARTED 1
[junit4] 2> 1190003 DEBUG (AutoscalingActionExecutor-3517-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers Resuming trigger: .auto_add_replicas after 100ms
[junit4] 2> 1190003 DEBUG (AutoscalingActionExecutor-3517-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers Resuming trigger: node_added_restore_trigger after
100ms
[junit4] 2> 1190003 DEBUG (AutoscalingActionExecutor-3517-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers -- processing took 99 ms for event
id=40b016f91bee3Teg9tkrd1ab03j9y9y0fv9sjl5
[junit4] 2> 1190005 INFO
(TEST-TestTriggerIntegration.testEventFromRestoredState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testEventFromRestoredState
[junit4] 2> 1190005 DEBUG
(TEST-TestTriggerIntegration.testEventFromRestoredState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode
version 11
[junit4] 2> 1190006 INFO
(TEST-TestTriggerIntegration.testEventFromRestoredState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimCloudManager === Restarting OverseerTriggerThread and
clearing object cache...
[junit4] 2> 1190017 WARN (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are
closed, exiting.
[junit4] 2> 1190017 DEBUG
(TEST-TestTriggerIntegration.testEventFromRestoredState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed
explicitly
[junit4] 2> 1190020 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Adding .autoAddReplicas trigger
[junit4] 2> 1190020 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode
version 12
[junit4] 2> 1190021 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10006_solr,
127.0.0.1:10005_solr]
[junit4] 2> 1190021 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 12, lastZnodeVersion -1
[junit4] 2> 1190021 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion
12
[junit4] 2> 1190023 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
[junit4] 2> 1190023 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 12, lastZnodeVersion 12
[junit4] 2> 1190026 DEBUG (ScheduledTrigger-3519-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2
[junit4] 2> 1190048 DEBUG (ScheduledTrigger-3519-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2
[junit4] 2> 1190068 DEBUG (ScheduledTrigger-3519-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2
[junit4] 2> 1190102 DEBUG (ScheduledTrigger-3519-thread-3) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2
[junit4] 2> 1190124 DEBUG (ScheduledTrigger-3519-thread-3) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 2
[junit4] 2> 1190124 DEBUG (simCloudManagerPool-3518-thread-1) [ ]
o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration
[junit4] 2> 1190124 DEBUG (simCloudManagerPool-3518-thread-1) [ ]
o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version
13
[junit4] 2> 1190134 DEBUG (simCloudManagerPool-3518-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10006_solr,
127.0.0.1:10005_solr]
[junit4] 2> 1190134 DEBUG (simCloudManagerPool-3518-thread-1) [ ]
o.a.s.c.a.NodeAddedTrigger Initial livenodes: [127.0.0.1:10006_solr,
127.0.0.1:10005_solr]
[junit4] 2> 1190134 DEBUG (simCloudManagerPool-3518-thread-1) [ ]
o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger instantiated
with properties: {event=nodeAdded, waitFor=10, actions=[{name=test,
class=org.apache.solr.cloud.autoscaling.sim.TestTriggerIntegration$TestTriggerAction}],
enabled=true}
[junit4] 2> 1190134 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion
13
[junit4] 2> 1190134 INFO (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.s.TestTriggerIntegration TestTriggerAction init
[junit4] 2> 1190134 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 13, lastZnodeVersion 13
[junit4] 2> 1190134 DEBUG (ScheduledTrigger-3519-thread-4) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 1190134 DEBUG (ScheduledTrigger-3519-thread-4) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 2
[junit4] 2> 1190150 DEBUG (ScheduledTrigger-3519-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 3
[junit4] 2> 1190165 DEBUG (ScheduledTrigger-3519-thread-4) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 1190165 DEBUG (ScheduledTrigger-3519-thread-4) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
[junit4] 2> 1190165 DEBUG (ScheduledTrigger-3519-thread-4) [ ]
o.a.s.c.a.NodeAddedTrigger Tracking new node: 127.0.0.1:10009_solr at time
1138009396025819
[junit4] 2> 1190174 DEBUG (ScheduledTrigger-3519-thread-3) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 3
[junit4] 2> 1190198 DEBUG (ScheduledTrigger-3519-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 3
[junit4] 2> 1190198 DEBUG (ScheduledTrigger-3519-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 1190198 DEBUG (ScheduledTrigger-3519-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
[junit4] 2> 1190219 DEBUG (ScheduledTrigger-3519-thread-2) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 1190219 DEBUG (ScheduledTrigger-3519-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 3
[junit4] 2> 1190219 DEBUG (ScheduledTrigger-3519-thread-2) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
[junit4] 2> 1190242 DEBUG (ScheduledTrigger-3519-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 3
[junit4] 2> 1190242 DEBUG (ScheduledTrigger-3519-thread-1) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 1190242 DEBUG (ScheduledTrigger-3519-thread-1) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
[junit4] 2> 1190265 DEBUG (ScheduledTrigger-3519-thread-2) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 1190265 DEBUG (ScheduledTrigger-3519-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 3
[junit4] 2> 1190265 DEBUG (ScheduledTrigger-3519-thread-2) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
[junit4] 2> 1190285 DEBUG (ScheduledTrigger-3519-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 3
[junit4] 2> 1190285 DEBUG (ScheduledTrigger-3519-thread-1) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 1190285 DEBUG (ScheduledTrigger-3519-thread-1) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
[junit4] 2> 1190332 DEBUG (ScheduledTrigger-3519-thread-2) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 1190332 DEBUG (ScheduledTrigger-3519-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 3
[junit4] 2> 1190332 DEBUG (ScheduledTrigger-3519-thread-2) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
[junit4] 2> 1190365 DEBUG (ScheduledTrigger-3519-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 1190365 DEBUG (ScheduledTrigger-3519-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 3
[junit4] 2> 1190365 DEBUG (ScheduledTrigger-3519-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
[junit4] 2> 1190387 DEBUG (ScheduledTrigger-3519-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 1190387 DEBUG (ScheduledTrigger-3519-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 3
[junit4] 2> 1190387 DEBUG (ScheduledTrigger-3519-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger firing
registered processor for nodes: [127.0.0.1:10009_solr] added at times
[1138009396025819], now=1138020441716719
[junit4] 2> 1190387 DEBUG (ScheduledTrigger-3519-thread-3) [ ]
o.a.s.c.a.ScheduledTriggers ++++++++ Cooldown inactive - processing event: {
[junit4] 2> "id":"40b0375cd19dbTeg9tkrd1ab03j9y9y0fv9sjl8",
[junit4] 2> "source":"node_added_trigger",
[junit4] 2> "eventTime":1138009396025819,
[junit4] 2> "eventType":"NODEADDED",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[1138009396025819],
[junit4] 2> "nodeNames":["127.0.0.1:10009_solr"]}}
[junit4] 2> 1190387 DEBUG (ScheduledTrigger-3519-thread-3) [ ]
o.a.s.c.a.ScheduledTriggers Pausing all triggers: [.auto_add_replicas,
node_added_trigger]
[junit4] 2> 1190397 DEBUG (AutoscalingActionExecutor-3520-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers -- processing actions for {
[junit4] 2> "id":"40b0375cd19dbTeg9tkrd1ab03j9y9y0fv9sjl8",
[junit4] 2> "source":"node_added_trigger",
[junit4] 2> "eventTime":1138009396025819,
[junit4] 2> "eventType":"NODEADDED",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[1138009396025819],
[junit4] 2> "_enqueue_time_":1138020464770769,
[junit4] 2> "nodeNames":["127.0.0.1:10009_solr"]}}
[junit4] 2> 1190398 DEBUG (AutoscalingActionExecutor-3520-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers Resuming trigger: .auto_add_replicas after 100ms
[junit4] 2> 1190398 DEBUG (AutoscalingActionExecutor-3520-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers Resuming trigger: node_added_trigger after 100ms
[junit4] 2> 1190398 DEBUG (AutoscalingActionExecutor-3520-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers -- processing took 52 ms for event
id=40b0375cd19dbTeg9tkrd1ab03j9y9y0fv9sjl8
[junit4] 2> 1190506 DEBUG (ScheduledTrigger-3519-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 4
[junit4] 2> 1190506 DEBUG (ScheduledTrigger-3519-thread-4) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 1190506 DEBUG (ScheduledTrigger-3519-thread-4) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 4
[junit4] 2> 1190506 DEBUG (ScheduledTrigger-3519-thread-4) [ ]
o.a.s.c.a.NodeAddedTrigger Tracking new node: 127.0.0.1:10010_solr at time
1138026408342469
[junit4] 2> 1190530 DEBUG (ScheduledTrigger-3519-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 1190530 DEBUG (ScheduledTrigger-3519-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 4
[junit4] 2> 1190530 DEBUG (ScheduledTrigger-3519-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 4
[junit4] 2> 1190551 DEBUG (ScheduledTrigger-3519-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 4
[junit4] 2> 1190551 DEBUG (ScheduledTrigger-3519-thread-1) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 1190551 DEBUG (ScheduledTrigger-3519-thread-1) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 4
[junit4] 2> 1190582 DEBUG (ScheduledTrigger-3519-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 4
[junit4] 2> 1190582 DEBUG (ScheduledTrigger-3519-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 1190582 DEBUG (ScheduledTrigger-3519-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 4
[junit4] 2> 1190598 INFO
(TEST-TestTriggerIntegration.testEventFromRestoredState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimCloudManager === Restarting OverseerTriggerThread and
clearing object cache...
[junit4] 2> 1190598 WARN (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Interrupted
[junit4] 2> java.lang.InterruptedException
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2014)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2048)
[junit4] 2> at
org.apache.solr.cloud.autoscaling.OverseerTriggerThread.run(OverseerTriggerThread.java:166)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 1190599 DEBUG
(TEST-TestTriggerIntegration.testEventFromRestoredState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed
explicitly
[junit4] 2> 1190609 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode
version 13
[junit4] 2> 1190609 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:10006_solr,
127.0.0.1:10010_solr, 127.0.0.1:10005_solr, 127.0.0.1:10009_solr]
[junit4] 2> 1190609 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.NodeAddedTrigger Initial livenodes: [127.0.0.1:10006_solr,
127.0.0.1:10010_solr, 127.0.0.1:10005_solr, 127.0.0.1:10009_solr]
[junit4] 2> 1190609 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger instantiated
with properties: {event=nodeAdded, waitFor=10, actions=[{name=test,
class=org.apache.solr.cloud.autoscaling.sim.TestTriggerIntegration$TestTriggerAction}],
enabled=true}
[junit4] 2> 1190609 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 13, lastZnodeVersion -1
[junit4] 2> 1190609 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion
13
[junit4] 2> 1190610 INFO (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.s.TestTriggerIntegration TestTriggerAction init
[junit4] 2> 1190610 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.NodeAddedTrigger Adding node from marker path: 127.0.0.1:10010_solr
[junit4] 2> 1190610 DEBUG (Simulated OverseerAutoScalingTriggerThread) [
] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 13, lastZnodeVersion 13
[junit4] 2> 1190611 DEBUG (ScheduledTrigger-3522-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 4
[junit4] 2> 1190611 DEBUG (ScheduledTrigger-3522-thread-1) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 1190611 DEBUG (ScheduledTrigger-3522-thread-1) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 4
[junit4] 2> 1190632 DEBUG (ScheduledTrigger-3522-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 4
[junit4] 2> 1190634 DEBUG (ScheduledTrigger-3522-thread-2) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 1190638 DEBUG (ScheduledTrigger-3522-thread-2) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 4
[junit4] 2> 1190654 DEBUG (ScheduledTrigger-3522-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 4
[junit4] 2> 1190659 DEBUG (ScheduledTrigger-3522-thread-1) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 1190659 DEBUG (ScheduledTrigger-3522-thread-1) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 4
[junit4] 2> 1190678 DEBUG (ScheduledTrigger-3522-thread-1) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 4
[junit4] 2> 1190680 DEBUG (ScheduledTrigger-3522-thread-1) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 1190680 DEBUG (ScheduledTrigger-3522-thread-1) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 4
[junit4] 2> 1190699 DEBUG (ScheduledTrigger-3522-thread-4) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 4
[junit4] 2> 1190701 DEBUG (ScheduledTrigger-3522-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 1190701 DEBUG (ScheduledTrigger-3522-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 4
[junit4] 2> 1190729 DEBUG (ScheduledTrigger-3522-thread-3) [ ]
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with
currently live nodes: 4
[junit4] 2> 1190729 DEBUG (ScheduledTrigger-3522-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger
[junit4] 2> 1190729 DEBUG (ScheduledTrigger-3522-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger Found livenodes: 4
[junit4] 2> 1190729 DEBUG (ScheduledTrigger-3522-thread-3) [ ]
o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger firing
registered processor for nodes: [127.0.0.1:10010_solr] added at times
[1138026408342469], now=1138037559462019
[junit4] 2> 1190729 DEBUG (ScheduledTrigger-3522-thread-3) [ ]
o.a.s.c.a.ScheduledTriggers ++++++++ Cooldown inactive - processing event: {
[junit4] 2> "id":"40b076bd073c5Teg9tkrd1ab03j9y9y0fv9sjlb",
[junit4] 2> "source":"node_added_trigger",
[junit4] 2> "eventTime":1138026408342469,
[junit4] 2> "eventType":"NODEADDED",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[1138026408342469],
[junit4] 2> "nodeNames":["127.0.0.1:10010_solr"]}}
[junit4] 2> 1190729 DEBUG (ScheduledTrigger-3522-thread-3) [ ]
o.a.s.c.a.ScheduledTriggers Pausing all triggers: [.auto_add_replicas,
node_added_trigger]
[junit4] 2> 1190729 DEBUG (AutoscalingActionExecutor-3523-thread-1) [ ]
o.a.s.c.a.ScheduledTriggers -- processing actions for {
[junit4] 2> "id":"40b076bd073c5Teg9tkrd1ab03j9y9y0fv9sjlb",
[junit4] 2> "source":"node_added_trigger",
[junit4] 2> "eventTime":1138026408342469,
[junit4] 2> "eventType":"NODEADDED",
[junit4] 2> "properties":{
[junit4] 2> "eventTimes":[1138026408342469],
[junit4] 2> "_enqueue_time_":1138037951594719,
[junit4] 2> "nodeNames":["127.0.0.1:10010_solr"]}}
[junit4] 2> 1190729 INFO
(TEST-TestTriggerIntegration.testEventFromRestoredState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testEventFromRestoredState
[junit4] 2> 1190729 INFO
(TEST-TestTriggerIntegration.testEventFromRestoredState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase
[junit4] 2>
[junit4] 2> 1190729 INFO
(TEST-TestTriggerIntegration.testEventFromRestoredState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase
#############################################
[junit4] 2> 1190729 INFO
(TEST-TestTriggerIntegration.testEventFromRestoredState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ############ FINAL CLUSTER STATS
############
[junit4] 2> 1190729 INFO
(TEST-TestTriggerIntegration.testEventFromRestoredState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase
#############################################
[junit4] 2>
[junit4] 2> 1190729 INFO
(TEST-TestTriggerIntegration.testEventFromRestoredState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ## Live nodes: 4
[junit4] 2> 1190729 INFO
(TEST-TestTriggerIntegration.testEventFromRestoredState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ## Empty nodes: 4
[junit4] 2> 1190729 INFO
(TEST-TestTriggerIntegration.testEventFromRestoredState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ## Dead nodes: 0
[junit4] 2> 1190729 INFO
(TEST-TestTriggerIntegration.testEventFromRestoredState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ## Collections: []
[junit4] 2> 1190729 INFO
(TEST-TestTriggerIntegration.testEventFromRestoredState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ## Max replicas per node: 0
[junit4] 2> 1190729 INFO
(TEST-TestTriggerIntegration.testEventFromRestoredState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ## Min replicas per node: 0
[junit4] 2> 1190729 INFO
(TEST-TestTriggerIntegration.testEventFromRestoredState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ## Total replicas: 0
[junit4] 2> 1190729 INFO
(TEST-TestTriggerIntegration.testEventFromRestoredState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ######### Final Solr op counts
##########
[junit4] 2> 1190729 INFO
(TEST-TestTriggerIntegration.testEventFromRestoredState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ## - autoscaling 1
[junit4] 2> 1190729 INFO
(TEST-TestTriggerIntegration.testEventFromRestoredState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ## - update 3
[junit4] 2> 1190729 INFO
(TEST-TestTriggerIntegration.testEventFromRestoredState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ######### Autoscaling event counts
###########
[junit4] 2> 1190729 INFO
(TEST-TestTriggerIntegration.testEventFromRestoredState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ## * Trigger: node_added_trigger
[junit4] 2> 1190729 INFO
(TEST-TestTriggerIntegration.testEventFromRestoredState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ## - STARTED 2
[junit4] 2> 1190729 INFO
(TEST-TestTriggerIntegration.testEventFromRestoredState-seed#[A2411F0DA6ABEF73])
[ ] o.a.s.c.a.s.SimSolrCloudTestCase ## - SUCCEEDED 1
[junit4] 2> 1190729 DEBUG (AutoscalingActionExecutor-3
[...truncated too long message...]
plitTest, TestOnReconnectListenerSupport, ZkFailoverTest,
UUIDUpdateProcessorFallbackTest, TestBinaryField, OutputWriterTest,
BasicAuthStandaloneTest, TestGeoJSONResponseWriter, HdfsRecoverLeaseTest,
TestPartialUpdateDeduplication, SolrGraphiteReporterTest, BlockDirectoryTest,
CollectionTooManyReplicasTest, TestFaceting, AnalysisAfterCoreReloadTest,
TestSkipOverseerOperations, MetricsConfigTest, DirectoryFactoryTest,
ForceLeaderTest, SolrJmxReporterTest, TestCloudRecovery,
TestLeaderElectionZkExpiry, TestRecovery, SolrTestCaseJ4Test,
LukeRequestHandlerTest, TestDynamicFieldResource,
AutoAddReplicasIntegrationTest, TestLegacyNumericRangeQueryBuilder,
TestInitParams, DistributedFacetExistsSmallTest,
SharedFSAutoReplicaFailoverTest, BitVectorTest,
CloneFieldUpdateProcessorFactoryTest, TestReplicaProperties,
TestHashQParserPlugin, LeaderElectionIntegrationTest,
HdfsUnloadDistributedZkTest, TestSchemaResource, TestSolrCloudWithKerberosAlt,
SSLMigrationTest, CacheHeaderTest, TestJavabinTupleStreamParser,
TestRealTimeGet, TestBackupRepositoryFactory, TestOmitPositions,
DeleteShardTest, SOLR749Test, LeaderInitiatedRecoveryOnShardRestartTest,
TestCharFilters, TestCollationField, TestRuleBasedAuthorizationPlugin,
LeaderElectionTest, RemoteQueryErrorTest, StatsReloadRaceTest, TestCryptoKeys,
TestZkChroot, TestIndexSearcher, HdfsThreadLeakTest, ExecutePlanActionTest,
TestRemoteStreaming, HLLUtilTest, TestFunctionQuery,
TestPayloadCheckQParserPlugin, ConfigureRecoveryStrategyTest, FullHLLTest,
TestSolrCloudWithHadoopAuthPlugin, HdfsDirectoryTest,
SuggestComponentContextFilterQueryTest, TestAuthorizationFramework,
TestCustomSort, TestPerFieldSimilarity, TermsComponentTest,
HttpTriggerListenerTest, TestXmlQParserPlugin, CoreAdminCreateDiscoverTest,
TestSchemaVersionResource, TestCloudNestedDocsSort, TestFieldCacheSortRandom,
TemplateUpdateProcessorTest, NodeAddedTriggerTest, SearchRateTriggerTest,
BlockJoinFacetDistribTest, TestLockTree, LIRRollingUpdatesTest,
TestCollectionAPI, TestLegacyField, TestClusterProperties,
TestTolerantUpdateProcessorCloud, RankQueryTest, TestDFISimilarityFactory,
XmlUpdateRequestHandlerTest, TestSystemCollAutoCreate, NumberUtilsTest,
TestRebalanceLeaders, TestUninvertingReader, DistributedFacetPivotLongTailTest,
TestFieldCacheReopen, TestSurroundQueryParser, AtomicUpdatesTest,
V2StandaloneTest, FieldMutatingUpdateProcessorTest, TestCoreAdminApis,
TestScoreJoinQPNoScore, IndexSchemaRuntimeFieldTest, TestRangeQuery,
TestFieldResource, TestSolrConfigHandlerCloud,
TestDistributedStatsComponentCardinality, TestJsonFacetRefinement,
OverseerCollectionConfigSetProcessorTest, OverseerModifyCollectionTest,
OverseerRolesTest, ReplaceNodeTest, ReplicationFactorTest,
SolrCloudExampleTest, TestCloudInspectUtil, TestConfigSetsAPI,
TestConfigSetsAPIExclusivity, TestDistribDocBasedVersion,
TestDownShardTolerantSearch, TestLeaderElectionWithEmptyReplica,
TestPullReplica, TestRandomFlRTGCloud, TestRandomRequestDistribution,
TestSSLRandomization, TestSegmentSorting, TestShortCircuitedRequests,
TestSizeLimitedDistributedMap, TestStressCloudBlindAtomicUpdates,
TestStressLiveNodes, TestTlogReplica, TestUtilizeNode,
TlogReplayBufferedWhileIndexingTest, TriLevelCompositeIdRoutingTest,
VMParamsZkACLAndCredentialsProvidersTest, ZkShardTermsTest, AssignTest,
CollectionsAPIAsyncDistributedZkTest, CollectionsAPIDistributedZkTest,
ConcurrentDeleteAndCreateCollectionTest, HdfsCollectionsAPIDistributedZkTest,
TestHdfsCloudBackupRestore, TestLocalFSCloudBackupRestore,
TestRequestStatusCollectionAPI, AutoScalingHandlerTest,
HdfsAutoAddReplicasIntegrationTest, SystemLogListenerTest, TestPolicyCloud,
TriggerIntegrationTest, TestClusterStateProvider, TestComputePlanAction,
TestExecutePlanAction, TestGenericDistributedQueue, TestLargeCluster,
TestNodeAddedTrigger, CdcrBootstrapTest, CdcrReplicationDistributedZkTest,
CdcrReplicationHandlerTest, CdcrRequestHandlerTest, CdcrVersionReplicationTest,
HDFSCollectionsAPITest, HdfsBasicDistributedZk2Test,
HdfsBasicDistributedZkTest, HdfsChaosMonkeyNothingIsSafeTest,
HdfsChaosMonkeySafeLeaderTest, HdfsNNFailoverTest, HdfsRecoveryZkTest,
HdfsRestartWhileUpdatingTest, TestClusterStateMutator, ZkStateReaderTest,
ImplicitSnitchTest, RuleEngineTest, RulesTest, BlobRepositoryCloudTest,
TestConfigSets, TestDynamicLoading, TestSolrXml, TestSolrCoreSnapshots,
TestCoreBackup, TestHdfsBackupRestoreCore, TestReplicationHandlerBackup,
TestRestoreCore, AutoscalingHistoryHandlerTest]
[junit4] Completed [628/775 (2!)] on J0 in 19.35s, 1 test, 1 failure <<<
FAILURES!
[...truncated 2885 lines...]
[junit4] Suite:
org.apache.solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory
[junit4] 2> Creating dataDir:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\init-core-data-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {},
docValues:{}, maxPointsInLeafNode=1701, maxMBSortInHeap=7.974955821396281,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@1b7f234),
locale=be, timezone=Europe/Kirov
[junit4] 2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_144
(32-bit)/cpus=3,threads=1,free=47529968,total=64880640
[junit4] 2> NOTE: All tests run in this JVM:
[TestICUCollationFieldOptions,
TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory]
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory
-Dtests.seed=70A3D25CF5F167EC -Dtests.slow=true -Dtests.locale=be
-Dtests.timezone=Europe/Kirov -Dtests.asserts=true
-Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.00s J1 |
TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory (suite) <<<
[junit4] > Throwable #1: java.io.IOException: Could not remove the
following files (in the order of attempts):
[junit4] >
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1\conf:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1\conf
[junit4] >
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1
[junit4] >
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001
[junit4] >
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1\conf\en-test-ner-person.bin:
java.nio.file.AccessDeniedException:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1\conf\en-test-ner-person.bin
[junit4] >
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1\conf\en-test-tokenizer.bin:
java.nio.file.AccessDeniedException:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1\conf\en-test-tokenizer.bin
[junit4] >
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1\conf\en-test-sent.bin:
java.nio.file.AccessDeniedException:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001\tempDir-001\collection1\conf\en-test-sent.bin
[junit4] >
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_70A3D25CF5F167EC-001
[junit4] > at
__randomizedtesting.SeedInfo.seed([70A3D25CF5F167EC]:0)
[junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] Completed [3/5 (1!)] on J1 in 1.46s, 8 tests, 1 error <<< FAILURES!
[...truncated 41511 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org
