Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Windows/472/ Java: 32bit/jdk1.8.0_144 -client -XX:+UseSerialGC
5 tests failed. FAILED: junit.framework.TestSuite.org.apache.solr.EchoParamsTest Error Message: Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.EchoParamsTest_A32C490431C1F1C2-001\init-core-data-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.EchoParamsTest_A32C490431C1F1C2-001\init-core-data-001 Stack Trace: java.io.IOException: Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.EchoParamsTest_A32C490431C1F1C2-001\init-core-data-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.EchoParamsTest_A32C490431C1F1C2-001\init-core-data-001 at __randomizedtesting.SeedInfo.seed([A32C490431C1F1C2]:0) at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329) at org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:216) at com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.lang.Thread.run(Thread.java:748) FAILED: org.apache.solr.cloud.autoscaling.TriggerIntegrationTest.testEventQueue Error Message: action wasn't interrupted Stack Trace: java.lang.AssertionError: action wasn't interrupted at __randomizedtesting.SeedInfo.seed([A32C490431C1F1C2:6A990BAA38A63737]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.apache.solr.cloud.autoscaling.TriggerIntegrationTest.testEventQueue(TriggerIntegrationTest.java:726) 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.rest.schema.TestBulkSchemaAPI Error Message: 1 thread leaked from SUITE scope at org.apache.solr.rest.schema.TestBulkSchemaAPI: 1) Thread[id=12013, name=qtp19872476-12013, state=TIMED_WAITING, group=TGRP-TestBulkSchemaAPI] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163) at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308) at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708) at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626) at java.lang.Thread.run(Thread.java:748) Stack Trace: com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.rest.schema.TestBulkSchemaAPI: 1) Thread[id=12013, name=qtp19872476-12013, state=TIMED_WAITING, group=TGRP-TestBulkSchemaAPI] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163) at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308) at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708) at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626) at java.lang.Thread.run(Thread.java:748) at __randomizedtesting.SeedInfo.seed([A32C490431C1F1C2]:0) FAILED: junit.framework.TestSuite.org.apache.solr.rest.schema.TestBulkSchemaAPI Error Message: There are still zombie threads that couldn't be terminated: 1) Thread[id=12013, name=qtp19872476-12013, state=TIMED_WAITING, group=TGRP-TestBulkSchemaAPI] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163) at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308) at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708) at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626) at java.lang.Thread.run(Thread.java:748) Stack Trace: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated: 1) Thread[id=12013, name=qtp19872476-12013, state=TIMED_WAITING, group=TGRP-TestBulkSchemaAPI] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163) at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308) at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708) at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626) at java.lang.Thread.run(Thread.java:748) at __randomizedtesting.SeedInfo.seed([A32C490431C1F1C2]:0) 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-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1\conf: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1\conf C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1 C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001 C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1\conf\en-test-tokenizer.bin: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1\conf\en-test-tokenizer.bin C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1\conf\en-test-ner-person.bin: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1\conf\en-test-ner-person.bin C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1\conf\en-test-sent.bin: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1\conf\en-test-sent.bin C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001 Stack Trace: java.io.IOException: Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1\conf: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1\conf C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1 C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001 C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1\conf\en-test-tokenizer.bin: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1\conf\en-test-tokenizer.bin C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1\conf\en-test-ner-person.bin: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1\conf\en-test-ner-person.bin C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1\conf\en-test-sent.bin: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1\conf\en-test-sent.bin C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001 at __randomizedtesting.SeedInfo.seed([1C7690B804FAC724]: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 12131 lines...] [junit4] Suite: org.apache.solr.EchoParamsTest [junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.EchoParamsTest_A32C490431C1F1C2-001\init-core-data-001 [junit4] 2> 21811 WARN (SUITE-EchoParamsTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2 [junit4] 2> 21811 INFO (SUITE-EchoParamsTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 21818 INFO (SUITE-EchoParamsTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN) [junit4] 2> 21819 INFO (SUITE-EchoParamsTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 21819 INFO (SUITE-EchoParamsTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 21820 INFO (SUITE-EchoParamsTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 21898 INFO (SUITE-EchoParamsTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0 [junit4] 2> 21916 INFO (SUITE-EchoParamsTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=test [junit4] 2> 21922 INFO (SUITE-EchoParamsTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 22015 WARN (SUITE-EchoParamsTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via JMX. [junit4] 2> 22015 WARN (SUITE-EchoParamsTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via JMX. [junit4] 2> 22015 WARN (SUITE-EchoParamsTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via JMX. [junit4] 2> 22018 INFO (coreLoadExecutor-57-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 22018 INFO (coreLoadExecutor-57-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 22090 INFO (coreLoadExecutor-57-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0 [junit4] 2> 22103 INFO (coreLoadExecutor-57-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 22108 INFO (coreLoadExecutor-57-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 22108 INFO (coreLoadExecutor-57-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1, trusted=true [junit4] 2> 22109 WARN (coreLoadExecutor-57-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via JMX. [junit4] 2> 22109 INFO (coreLoadExecutor-57-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 22109 INFO (coreLoadExecutor-57-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.EchoParamsTest_A32C490431C1F1C2-001\init-core-data-001\] [junit4] 2> 22113 INFO (coreLoadExecutor-57-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=31, maxMergeAtOnceExplicit=48, maxMergedSegmentMB=99.5078125, floorSegmentMB=1.5859375, forceMergeDeletesPctAllowed=20.633072445564178, segmentsPerTier=12.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0 [junit4] 2> 22146 INFO (coreLoadExecutor-57-thread-1) [ x:collection1] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=60 [junit4] 2> 22227 INFO (coreLoadExecutor-57-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 22227 INFO (coreLoadExecutor-57-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 22229 INFO (coreLoadExecutor-57-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=33, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7040324949807278] [junit4] 2> 22229 INFO (coreLoadExecutor-57-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@b452fa[collection1] main] [junit4] 2> 22230 WARN (coreLoadExecutor-57-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf; switching to use InMemory storage instead. [junit4] 2> 22231 INFO (coreLoadExecutor-57-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 22232 INFO (searcherExecutor-58-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@b452fa[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 22236 INFO (SUITE-EchoParamsTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 22238 INFO (TEST-EchoParamsTest.test-seed#[A32C490431C1F1C2]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test [junit4] 2> 22253 INFO (TEST-EchoParamsTest.test-seed#[A32C490431C1F1C2]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=foo&qt=&start=0&rows=20&version=2.2&wt=xml} hits=0 status=0 QTime=15 [junit4] 2> 22260 INFO (TEST-EchoParamsTest.test-seed#[A32C490431C1F1C2]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=foo&qt=&start=0&rows=20&version=2.2&wt=xml} hits=0 status=0 QTime=0 [junit4] 2> 22260 INFO (TEST-EchoParamsTest.test-seed#[A32C490431C1F1C2]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=foo&qt=&start=0&rows=20&wt=xml} hits=0 status=0 QTime=0 [junit4] 2> 22261 INFO (TEST-EchoParamsTest.test-seed#[A32C490431C1F1C2]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=foo&qt=&start=0&rows=20&wt=xml} hits=0 status=0 QTime=0 [junit4] 2> 22263 INFO (TEST-EchoParamsTest.test-seed#[A32C490431C1F1C2]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=foo&qt=&echoParams=explicit&start=0&rows=20&wt=xml&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 22263 INFO (TEST-EchoParamsTest.test-seed#[A32C490431C1F1C2]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=foo&qt=&echoParams=explicit&start=0&rows=20&wt=xml&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 22264 INFO (TEST-EchoParamsTest.test-seed#[A32C490431C1F1C2]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=foo&qt=&echoParams=explicit&start=0&rows=20&wt=xml&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 22265 INFO (TEST-EchoParamsTest.test-seed#[A32C490431C1F1C2]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={echoHandler=true&q=foo&qt=/crazy_custom_qt&echoParams=all&start=0&rows=20&version=2.2&wt=xml} hits=0 status=0 QTime=0 [junit4] 2> 22266 INFO (TEST-EchoParamsTest.test-seed#[A32C490431C1F1C2]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={echoHandler=true&q=foo&qt=/crazy_custom_qt&echoParams=all&start=0&rows=20&version=2.2&wt=xml} hits=0 status=0 QTime=0 [junit4] 2> 22266 INFO (TEST-EchoParamsTest.test-seed#[A32C490431C1F1C2]) [ ] o.a.s.SolrTestCaseJ4 ###Ending test [junit4] 2> 22266 INFO (SUITE-EchoParamsTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 22266 INFO (SUITE-EchoParamsTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=427348 [junit4] 2> 22267 INFO (SUITE-EchoParamsTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 22267 INFO (SUITE-EchoParamsTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3cfbc: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / null [junit4] 2> 22267 INFO (SUITE-EchoParamsTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 22267 INFO (SUITE-EchoParamsTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5c3dd9: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / null [junit4] 2> 22267 INFO (SUITE-EchoParamsTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 22267 INFO (SUITE-EchoParamsTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@52bcc5: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / null [junit4] 2> 22268 INFO (coreCloseExecutor-62-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1ac999b [junit4] 2> 22268 INFO (coreCloseExecutor-62-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=28088731 [junit4] 2> 22268 INFO (coreCloseExecutor-62-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@11cb92c: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / null [junit4] 2> 22271 INFO (SUITE-EchoParamsTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.SolrTestCaseJ4 ------------------------------------------------------- Done waiting for tracked resources to be released [junit4] 2> NOTE: test params are: codec=CheapBastard, sim=RandomSimilarity(queryNorm=false): {}, locale=nn-NO, timezone=NZ [junit4] 2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_144 (32-bit)/cpus=3,threads=1,free=19361856,total=51142656 [junit4] 2> NOTE: All tests run in this JVM: [DocExpirationUpdateProcessorFactoryTest, TestUseDocValuesAsStored2, TestManagedResourceStorage, TestDynamicFieldCollectionResource, ActionThrottleTest, ExternalFileFieldSortTest, EchoParamsTest] [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=EchoParamsTest -Dtests.seed=A32C490431C1F1C2 -Dtests.slow=true -Dtests.locale=nn-NO -Dtests.timezone=NZ -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 0.00s J1 | EchoParamsTest (suite) <<< [junit4] > Throwable #1: java.io.IOException: Could not remove the following files (in the order of attempts): [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.EchoParamsTest_A32C490431C1F1C2-001\init-core-data-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.EchoParamsTest_A32C490431C1F1C2-001\init-core-data-001 [junit4] > at __randomizedtesting.SeedInfo.seed([A32C490431C1F1C2]:0) [junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329) [junit4] > at java.lang.Thread.run(Thread.java:748) [junit4] Completed [8/777 (1!)] on J1 in 0.49s, 1 test, 1 error <<< FAILURES! [...truncated 471 lines...] [junit4] Suite: org.apache.solr.cloud.autoscaling.TriggerIntegrationTest [junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.TriggerIntegrationTest_A32C490431C1F1C2-001\init-core-data-001 [junit4] 2> 330158 WARN (SUITE-TriggerIntegrationTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=4 numCloses=4 [junit4] 2> 330158 INFO (SUITE-TriggerIntegrationTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 330162 INFO (SUITE-TriggerIntegrationTest-seed#[A32C490431C1F1C2]-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> 330162 INFO (SUITE-TriggerIntegrationTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 330164 INFO (SUITE-TriggerIntegrationTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.TriggerIntegrationTest_A32C490431C1F1C2-001\tempDir-001 [junit4] 2> 330164 INFO (SUITE-TriggerIntegrationTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 330164 INFO (Thread-642) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 330164 INFO (Thread-642) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 330168 ERROR (Thread-642) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes [junit4] 2> 330264 INFO (SUITE-TriggerIntegrationTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:58093 [junit4] 2> 330270 INFO (zkConnectionManagerCallback-646-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 330274 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x100af03f59d0000, likely client has closed socket [junit4] 2> 330277 INFO (jetty-launcher-643-thread-2) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T23:27:37+02:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 330277 INFO (jetty-launcher-643-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 330277 INFO (jetty-launcher-643-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 330277 INFO (jetty-launcher-643-thread-2) [ ] o.e.j.s.session Scavenging every 660000ms [junit4] 2> 330277 INFO (jetty-launcher-643-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@fc5dea{/solr,null,AVAILABLE} [junit4] 2> 330279 INFO (jetty-launcher-643-thread-1) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T23:27:37+02:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 330279 INFO (jetty-launcher-643-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 330279 INFO (jetty-launcher-643-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 330279 INFO (jetty-launcher-643-thread-1) [ ] o.e.j.s.session Scavenging every 660000ms [junit4] 2> 330279 INFO (jetty-launcher-643-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1d21846{/solr,null,AVAILABLE} [junit4] 2> 330284 INFO (jetty-launcher-643-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1ebd725{HTTP/1.1,[http/1.1]}{127.0.0.1:58100} [junit4] 2> 330284 INFO (jetty-launcher-643-thread-1) [ ] o.e.j.s.Server Started @337724ms [junit4] 2> 330284 INFO (jetty-launcher-643-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=58100} [junit4] 2> 330285 ERROR (jetty-launcher-643-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 330285 INFO (jetty-launcher-643-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.3.0 [junit4] 2> 330285 INFO (jetty-launcher-643-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 330285 INFO (jetty-launcher-643-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 330285 INFO (jetty-launcher-643-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-02-23T23:20:40.472Z [junit4] 2> 330285 INFO (jetty-launcher-643-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5b20c3{HTTP/1.1,[http/1.1]}{127.0.0.1:58097} [junit4] 2> 330285 INFO (jetty-launcher-643-thread-2) [ ] o.e.j.s.Server Started @337725ms [junit4] 2> 330285 INFO (jetty-launcher-643-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=58097} [junit4] 2> 330285 ERROR (jetty-launcher-643-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 330285 INFO (jetty-launcher-643-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.3.0 [junit4] 2> 330285 INFO (jetty-launcher-643-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 330285 INFO (jetty-launcher-643-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 330285 INFO (jetty-launcher-643-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-02-23T23:20:40.472Z [junit4] 2> 330291 INFO (zkConnectionManagerCallback-648-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 330292 INFO (zkConnectionManagerCallback-650-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 330293 INFO (jetty-launcher-643-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 330293 INFO (jetty-launcher-643-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 330306 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x100af03f59d0002, likely client has closed socket [junit4] 2> 330312 INFO (jetty-launcher-643-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58093/solr [junit4] 2> 330498 INFO (zkConnectionManagerCallback-654-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 330503 INFO (jetty-launcher-643-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58093/solr [junit4] 2> 330505 INFO (zkConnectionManagerCallback-656-thread-1-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 330510 INFO (zkConnectionManagerCallback-660-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 330513 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x100af03f59d0005, likely client has closed socket [junit4] 2> 330529 INFO (zkConnectionManagerCallback-662-thread-1-processing-n:127.0.0.1:58097_solr) [n:127.0.0.1:58097_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 330768 INFO (jetty-launcher-643-thread-2) [n:127.0.0.1:58097_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 330768 INFO (jetty-launcher-643-thread-1) [n:127.0.0.1:58100_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 330769 INFO (jetty-launcher-643-thread-2) [n:127.0.0.1:58097_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:58097_solr [junit4] 2> 330770 INFO (jetty-launcher-643-thread-1) [n:127.0.0.1:58100_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:58100_solr [junit4] 2> 330771 INFO (jetty-launcher-643-thread-2) [n:127.0.0.1:58097_solr ] o.a.s.c.Overseer Overseer (id=72250025578397702-127.0.0.1:58097_solr-n_0000000000) starting [junit4] 2> 330788 INFO (jetty-launcher-643-thread-2) [n:127.0.0.1:58097_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:58097_solr [junit4] 2> 330972 DEBUG (OverseerAutoScalingTriggerThread-72250025578397702-127.0.0.1:58097_solr-n_0000000000) [n:127.0.0.1:58097_solr ] o.a.s.c.a.OverseerTriggerThread Adding .autoAddReplicas trigger [junit4] 2> 330980 DEBUG (OverseerAutoScalingTriggerThread-72250025578397702-127.0.0.1:58097_solr-n_0000000000) [n:127.0.0.1:58097_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1 [junit4] 2> 330980 INFO (zkCallback-655-thread-1-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 330981 INFO (zkCallback-661-thread-1-processing-n:127.0.0.1:58097_solr) [n:127.0.0.1:58097_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 330982 DEBUG (OverseerAutoScalingTriggerThread-72250025578397702-127.0.0.1:58097_solr-n_0000000000) [n:127.0.0.1:58097_solr ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:58100_solr, 127.0.0.1:58097_solr] [junit4] 2> 330982 DEBUG (OverseerAutoScalingTriggerThread-72250025578397702-127.0.0.1:58097_solr-n_0000000000) [n:127.0.0.1:58097_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion -1 [junit4] 2> 330982 DEBUG (OverseerAutoScalingTriggerThread-72250025578397702-127.0.0.1:58097_solr-n_0000000000) [n:127.0.0.1:58097_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1 [junit4] 2> 330989 DEBUG (OverseerAutoScalingTriggerThread-72250025578397702-127.0.0.1:58097_solr-n_0000000000) [n:127.0.0.1:58097_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers [junit4] 2> 330993 DEBUG (OverseerAutoScalingTriggerThread-72250025578397702-127.0.0.1:58097_solr-n_0000000000) [n:127.0.0.1:58097_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1 [junit4] 2> 331062 INFO (jetty-launcher-643-thread-2) [n:127.0.0.1:58097_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58097.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@15ce9fc [junit4] 2> 331071 INFO (jetty-launcher-643-thread-2) [n:127.0.0.1:58097_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58097.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@15ce9fc [junit4] 2> 331071 INFO (jetty-launcher-643-thread-2) [n:127.0.0.1:58097_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58097.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@15ce9fc [junit4] 2> 331079 INFO (jetty-launcher-643-thread-1) [n:127.0.0.1:58100_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58100.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@15ce9fc [junit4] 2> 331093 INFO (jetty-launcher-643-thread-1) [n:127.0.0.1:58100_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58100.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@15ce9fc [junit4] 2> 331093 INFO (jetty-launcher-643-thread-1) [n:127.0.0.1:58100_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58100.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@15ce9fc [junit4] 2> 331094 INFO (jetty-launcher-643-thread-2) [n:127.0.0.1:58097_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.TriggerIntegrationTest_A32C490431C1F1C2-001\tempDir-001\node2\. [junit4] 2> 331096 INFO (jetty-launcher-643-thread-1) [n:127.0.0.1:58100_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.TriggerIntegrationTest_A32C490431C1F1C2-001\tempDir-001\node1\. [junit4] 2> 331098 DEBUG (ScheduledTrigger-1494-thread-1) [n:127.0.0.1:58097_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 [junit4] 2> 331424 INFO (zkConnectionManagerCallback-668-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 331433 INFO (zkConnectionManagerCallback-672-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 331434 INFO (SUITE-TriggerIntegrationTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 331435 INFO (SUITE-TriggerIntegrationTest-seed#[A32C490431C1F1C2]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:58093/solr ready [junit4] 2> 331452 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testTriggerThrottling [junit4] 2> 331456 INFO (qtp5089530-3036) [n:127.0.0.1:58097_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :overseerstatus with params action=OVERSEERSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 331473 INFO (qtp5089530-3036) [n:127.0.0.1:58097_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=OVERSEERSTATUS&wt=javabin&version=2} status=0 QTime=17 [junit4] 2> 331475 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.c.a.ScheduledTriggers -- removing trigger: .auto_add_replicas [junit4] 2> 331481 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.c.a.TriggerIntegrationTest /autoscaling.json reset, new znode version 2 [junit4] 2> 331484 DEBUG (zkCallback-661-thread-1-processing-n:127.0.0.1:58097_solr) [n:127.0.0.1:58097_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 2 [junit4] 2> 331484 DEBUG (OverseerAutoScalingTriggerThread-72250025578397702-127.0.0.1:58097_solr-n_0000000000) [n:127.0.0.1:58097_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 2 [junit4] 2> 331484 DEBUG (OverseerAutoScalingTriggerThread-72250025578397702-127.0.0.1:58097_solr-n_0000000000) [n:127.0.0.1:58097_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeLost markers [junit4] 2> 331485 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 331485 DEBUG (OverseerAutoScalingTriggerThread-72250025578397702-127.0.0.1:58097_solr-n_0000000000) [n:127.0.0.1:58097_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers [junit4] 2> 331485 DEBUG (OverseerAutoScalingTriggerThread-72250025578397702-127.0.0.1:58097_solr-n_0000000000) [n:127.0.0.1:58097_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 2, lastZnodeVersion 2 [junit4] 2> 331487 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@5b20c3{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 331488 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=20519641 [junit4] 2> 331489 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 331489 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1a4a5e9: rootName = solr_58097, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@e76f1f [junit4] 2> 331494 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 331494 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@19f7f7b: rootName = solr_58097, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@5e1a7b [junit4] 2> 331498 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 331498 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4bc6a9: rootName = solr_58097, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@1c11675 [junit4] 2> 331500 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:58097_solr [junit4] 2> 331503 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 331503 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 331504 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.c.Overseer Overseer (id=72250025578397702-127.0.0.1:58097_solr-n_0000000000) closing [junit4] 2> 331505 INFO (OverseerStateUpdate-72250025578397702-127.0.0.1:58097_solr-n_0000000000) [n:127.0.0.1:58097_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:58097_solr [junit4] 2> 331508 DEBUG (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly [junit4] 2> 331509 WARN (OverseerAutoScalingTriggerThread-72250025578397702-127.0.0.1:58097_solr-n_0000000000) [n:127.0.0.1:58097_solr ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting. [junit4] 2> 331512 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x100af03f59d0006, likely client has closed socket [junit4] 2> 331512 INFO (zkCallback-661-thread-1-processing-n:127.0.0.1:58097_solr) [n:127.0.0.1:58097_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1) [junit4] 2> 331512 INFO (zkCallback-655-thread-1-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1) [junit4] 2> 331513 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@fc5dea{/solr,null,UNAVAILABLE} [junit4] 2> 331513 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.e.j.s.session Stopped scavenging [junit4] 2> 331513 INFO (zkCallback-671-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1) [junit4] 2> 331514 INFO (zkCallback-671-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1) [junit4] 2> 331515 INFO (zkCallback-655-thread-2-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:58100_solr [junit4] 2> 331515 INFO (zkCallback-655-thread-2-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.Overseer Overseer (id=72250025578397700-127.0.0.1:58100_solr-n_0000000001) starting [junit4] 2> 331525 DEBUG (OverseerAutoScalingTriggerThread-72250025578397700-127.0.0.1:58100_solr-n_0000000001) [n:127.0.0.1:58100_solr ] o.a.s.c.a.OverseerTriggerThread Adding .autoAddReplicas trigger [junit4] 2> 331527 DEBUG (OverseerAutoScalingTriggerThread-72250025578397700-127.0.0.1:58100_solr-n_0000000001) [n:127.0.0.1:58100_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 3 [junit4] 2> 331527 DEBUG (OverseerAutoScalingTriggerThread-72250025578397700-127.0.0.1:58100_solr-n_0000000001) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:58100_solr] [junit4] 2> 331527 DEBUG (OverseerAutoScalingTriggerThread-72250025578397700-127.0.0.1:58100_solr-n_0000000001) [n:127.0.0.1:58100_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3, lastZnodeVersion -1 [junit4] 2> 331528 DEBUG (OverseerAutoScalingTriggerThread-72250025578397700-127.0.0.1:58100_solr-n_0000000001) [n:127.0.0.1:58100_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 3 [junit4] 2> 331529 DEBUG (OverseerAutoScalingTriggerThread-72250025578397700-127.0.0.1:58100_solr-n_0000000001) [n:127.0.0.1:58100_solr ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers [junit4] 2> 331531 DEBUG (OverseerAutoScalingTriggerThread-72250025578397700-127.0.0.1:58100_solr-n_0000000001) [n:127.0.0.1:58100_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 3, lastZnodeVersion 3 [junit4] 2> 331531 DEBUG (ScheduledTrigger-1503-thread-1) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 332533 DEBUG (ScheduledTrigger-1503-thread-1) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 333534 DEBUG (ScheduledTrigger-1503-thread-2) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 334536 DEBUG (ScheduledTrigger-1503-thread-1) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 335537 DEBUG (ScheduledTrigger-1503-thread-1) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 336517 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T23:27:37+02:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 336519 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 336519 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 336519 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.e.j.s.session Scavenging every 660000ms [junit4] 2> 336521 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1c341b0{/solr,null,AVAILABLE} [junit4] 2> 336522 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@17ab75a{HTTP/1.1,[http/1.1]}{127.0.0.1:58211} [junit4] 2> 336522 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.e.j.s.Server Started @343962ms [junit4] 2> 336522 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=58211} [junit4] 2> 336522 ERROR (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 336522 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.3.0 [junit4] 2> 336522 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 336522 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 336522 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-02-23T23:20:46.709Z [junit4] 2> 336527 INFO (zkConnectionManagerCallback-675-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 336528 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 336544 DEBUG (ScheduledTrigger-1503-thread-1) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 336549 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58093/solr [junit4] 2> 336551 INFO (zkConnectionManagerCallback-679-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 336556 INFO (zkConnectionManagerCallback-681-thread-1-processing-n:127.0.0.1:58211_solr) [n:127.0.0.1:58211_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 336565 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [n:127.0.0.1:58211_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 336566 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [n:127.0.0.1:58211_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 336572 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [n:127.0.0.1:58211_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:58211_solr [junit4] 2> 336575 INFO (zkCallback-671-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 336575 INFO (zkCallback-671-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 336575 INFO (zkCallback-655-thread-2-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 336576 INFO (zkCallback-680-thread-1-processing-n:127.0.0.1:58211_solr) [n:127.0.0.1:58211_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 336717 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [n:127.0.0.1:58211_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58211.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@15ce9fc [junit4] 2> 336735 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [n:127.0.0.1:58211_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58211.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@15ce9fc [junit4] 2> 336735 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [n:127.0.0.1:58211_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58211.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@15ce9fc [junit4] 2> 336738 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [n:127.0.0.1:58211_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.TriggerIntegrationTest_A32C490431C1F1C2-001\tempDir-001\node3\. [junit4] 2> 336790 INFO (qtp24431827-3040) [n:127.0.0.1:58100_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=1 [junit4] 2> 336794 INFO (qtp4875339-3109) [n:127.0.0.1:58211_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=1 [junit4] 2> 336795 DEBUG (qtp24431827-3045) [n:127.0.0.1:58100_solr ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration [junit4] 2> 336796 INFO (qtp24431827-3045) [n:127.0.0.1:58100_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=10 [junit4] 2> 336796 DEBUG (zkCallback-655-thread-2-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 4 [junit4] 2> 336797 DEBUG (zkCallback-655-thread-2-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:58211_solr, 127.0.0.1:58100_solr] [junit4] 2> 336798 DEBUG (zkCallback-655-thread-2-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeAddedTrigger Initial livenodes: [127.0.0.1:58211_solr, 127.0.0.1:58100_solr] [junit4] 2> 336798 DEBUG (zkCallback-655-thread-2-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] 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.TriggerIntegrationTest$ThrottlingTesterAction}], enabled=true} [junit4] 2> 336798 DEBUG (OverseerAutoScalingTriggerThread-72250025578397700-127.0.0.1:58100_solr-n_0000000001) [n:127.0.0.1:58100_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 4 [junit4] 2> 336801 INFO (qtp24431827-3040) [n:127.0.0.1:58100_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=1 [junit4] 2> 336803 INFO (qtp4875339-3111) [n:127.0.0.1:58211_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=1 [junit4] 2> 336804 DEBUG (qtp24431827-3042) [n:127.0.0.1:58100_solr ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration [junit4] 2> 336804 INFO (qtp24431827-3042) [n:127.0.0.1:58100_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=6 [junit4] 2> 336804 INFO (OverseerAutoScalingTriggerThread-72250025578397700-127.0.0.1:58100_solr-n_0000000001) [n:127.0.0.1:58100_solr ] o.a.s.c.a.TriggerIntegrationTest TestTriggerAction init [junit4] 2> 336805 DEBUG (zkCallback-655-thread-2-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 5 [junit4] 2> 336805 DEBUG (zkCallback-655-thread-2-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeAddedTrigger Initial livenodes: [127.0.0.1:58211_solr, 127.0.0.1:58100_solr] [junit4] 2> 336805 DEBUG (zkCallback-655-thread-2-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] 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.TriggerIntegrationTest$ThrottlingTesterAction}], enabled=true} [junit4] 2> 336805 DEBUG (ScheduledTrigger-1503-thread-3) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger1 [junit4] 2> 336805 DEBUG (ScheduledTrigger-1503-thread-3) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 2 [junit4] 2> 336805 DEBUG (zkCallback-655-thread-2-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:58211_solr, 127.0.0.1:58100_solr] [junit4] 2> 336806 DEBUG (zkCallback-655-thread-2-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeAddedTrigger Initial livenodes: [127.0.0.1:58211_solr, 127.0.0.1:58100_solr] [junit4] 2> 336806 DEBUG (zkCallback-655-thread-2-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] 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.TriggerIntegrationTest$ThrottlingTesterAction}], enabled=true} [junit4] 2> 336806 DEBUG (OverseerAutoScalingTriggerThread-72250025578397700-127.0.0.1:58100_solr-n_0000000001) [n:127.0.0.1:58100_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 5, lastZnodeVersion 4 [junit4] 2> 336806 DEBUG (OverseerAutoScalingTriggerThread-72250025578397700-127.0.0.1:58100_solr-n_0000000001) [n:127.0.0.1:58100_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 5 [junit4] 2> 336807 INFO (OverseerAutoScalingTriggerThread-72250025578397700-127.0.0.1:58100_solr-n_0000000001) [n:127.0.0.1:58100_solr ] o.a.s.c.a.TriggerIntegrationTest TestTriggerAction init [junit4] 2> 336807 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T23:27:37+02:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 336807 DEBUG (OverseerAutoScalingTriggerThread-72250025578397700-127.0.0.1:58100_solr-n_0000000001) [n:127.0.0.1:58100_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 5, lastZnodeVersion 5 [junit4] 2> 336807 DEBUG (ScheduledTrigger-1503-thread-4) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger2 [junit4] 2> 336807 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 336807 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 336807 DEBUG (ScheduledTrigger-1503-thread-4) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 2 [junit4] 2> 336807 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.e.j.s.session Scavenging every 660000ms [junit4] 2> 336811 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@19c7009{/solr,null,AVAILABLE} [junit4] 2> 336811 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@15fef79{HTTP/1.1,[http/1.1]}{127.0.0.1:58226} [junit4] 2> 336811 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.e.j.s.Server Started @344251ms [junit4] 2> 336811 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=58226} [junit4] 2> 336811 ERROR (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 336811 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.3.0 [junit4] 2> 336811 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 336811 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 336811 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-02-23T23:20:46.998Z [junit4] 2> 336814 INFO (zkConnectionManagerCallback-685-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 336815 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 336827 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x100af03f59d000c, likely client has closed socket [junit4] 2> 336831 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58093/solr [junit4] 2> 336833 INFO (zkConnectionManagerCallback-689-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 336837 INFO (zkConnectionManagerCallback-691-thread-1-processing-n:127.0.0.1:58226_solr) [n:127.0.0.1:58226_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 336847 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [n:127.0.0.1:58226_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 336850 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [n:127.0.0.1:58226_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 336854 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [n:127.0.0.1:58226_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:58226_solr [junit4] 2> 336856 INFO (zkCallback-655-thread-2-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 336856 INFO (zkCallback-671-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 336857 INFO (zkCallback-680-thread-1-processing-n:127.0.0.1:58211_solr) [n:127.0.0.1:58211_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 336857 INFO (zkCallback-671-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 336858 INFO (zkCallback-690-thread-1-processing-n:127.0.0.1:58226_solr) [n:127.0.0.1:58226_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 337219 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [n:127.0.0.1:58226_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58226.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@15ce9fc [junit4] 2> 337229 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [n:127.0.0.1:58226_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58226.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@15ce9fc [junit4] 2> 337229 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [n:127.0.0.1:58226_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58226.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@15ce9fc [junit4] 2> 337231 INFO (TEST-TriggerIntegrationTest.testTriggerThrottling-seed#[A32C490431C1F1C2]) [n:127.0.0.1:58226_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.TriggerIntegrationTest_A32C490431C1F1C2-001\tempDir-001\node4\. [junit4] 2> 337546 DEBUG (ScheduledTrigger-1503-thread-1) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 3 [junit4] 2> 337808 DEBUG (ScheduledTrigger-1503-thread-2) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger1 [junit4] 2> 337809 DEBUG (ScheduledTrigger-1503-thread-2) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 3 [junit4] 2> 337812 DEBUG (ScheduledTrigger-1503-thread-4) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger2 [junit4] 2> 337812 DEBUG (ScheduledTrigger-1503-thread-4) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 3 [junit4] 2> 337812 DEBUG (ScheduledTrigger-1503-thread-4) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeAddedTrigger Tracking new node: 127.0.0.1:58226_solr at time 2936279930489039 [junit4] 2> 337812 DEBUG (ScheduledTrigger-1503-thread-4) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger2 firing registered processor for nodes: [127.0.0.1:58226_solr] added at times [2936279930489039], now=2936279930538248 [junit4] 2> 337812 DEBUG (ScheduledTrigger-1503-thread-4) [n:127.0.0.1:58100_solr ] o.a.s.c.a.ScheduledTriggers ++++++++ Cooldown inactive - processing event: { [junit4] 2> "id":"a6e87f237c8cfT732ukvjnyoqcuvvfgi0hwiz95", [junit4] 2> "source":"node_added_trigger2", [junit4] 2> "eventTime":2936279930489039, [junit4] 2> "eventType":"NODEADDED", [junit4] 2> "properties":{ [junit4] 2> "eventTimes":[2936279930489039], [junit4] 2> "nodeNames":["127.0.0.1:58226_solr"]}} [junit4] 2> 337812 DEBUG (ScheduledTrigger-1503-thread-2) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeAddedTrigger Tracking new node: 127.0.0.1:58226_solr at time 2936279930504399 [junit4] 2> 337813 DEBUG (ScheduledTrigger-1503-thread-2) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger1 firing registered processor for nodes: [127.0.0.1:58226_solr] added at times [2936279930504399], now=2936279931407789 [junit4] 2> 337813 DEBUG (ScheduledTrigger-1503-thread-2) [n:127.0.0.1:58100_solr ] o.a.s.c.a.ScheduledTriggers ++++++++ Cooldown inactive - processing event: { [junit4] 2> "id":"a6e87f23804cfT732ukvjnyoqcuvvfgi0hwiz96", [junit4] 2> "source":"node_added_trigger1", [junit4] 2> "eventTime":2936279930504399, [junit4] 2> "eventType":"NODEADDED", [junit4] 2> "properties":{ [junit4] 2> "eventTimes":[2936279930504399], [junit4] 2> "nodeNames":["127.0.0.1:58226_solr"]}} [junit4] 2> 337813 DEBUG (ScheduledTrigger-1503-thread-4) [n:127.0.0.1:58100_solr ] o.a.s.c.a.ScheduledTriggers Pausing all triggers: [.auto_add_replicas, node_added_trigger2, node_added_trigger1] [junit4] 2> 337813 INFO (ScheduledTrigger-1503-thread-2) [n:127.0.0.1:58100_solr ] o.a.s.c.a.SystemLogListener Collection .system does not exist, disabling logging. [junit4] 2> 337815 INFO (ScheduledTrigger-1503-thread-4) [n:127.0.0.1:58100_solr ] o.a.s.c.a.SystemLogListener Collection .system does not exist, disabling logging. [junit4] 2> 337819 DEBUG (AutoscalingActionExecutor-1504-thread-1-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.ScheduledTriggers -- processing actions for { [junit4] 2> "id":"a6e87f237c8cfT732ukvjnyoqcuvvfgi0hwiz95", [junit4] 2> "source":"node_added_trigger2", [junit4] 2> "eventTime":2936279930489039, [junit4] 2> "eventType":"NODEADDED", [junit4] 2> "properties":{ [junit4] 2> "eventTimes":[2936279930489039], [junit4] 2> "_enqueue_time_":2936279931752249, [junit4] 2> "nodeNames":["127.0.0.1:58226_solr"]}} [junit4] 2> 337819 INFO (AutoscalingActionExecutor-1504-thread-1-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.TriggerIntegrationTest action executed from node_added_trigger2 [junit4] 2> 337822 DEBUG (AutoscalingActionExecutor-1504-thread-1-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.ScheduledTriggers Resuming trigger: .auto_add_replicas after 5000ms [junit4] 2> 337822 DEBUG (AutoscalingActionExecutor-1504-thread-1-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.ScheduledTriggers Resuming trigger: node_added_trigger2 after 5000ms [junit4] 2> 337822 DEBUG (AutoscalingActionExecutor-1504-thread-1-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.ScheduledTriggers Resuming trigger: node_added_trigger1 after 5000ms [junit4] 2> 337822 DEBUG (AutoscalingActionExecutor-1504-thread-1-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.ScheduledTriggers -- processing took 4 ms for event id=a6e87f237c8cfT732ukvjnyoqcuvvfgi0hwiz95 [junit4] 2> 342823 DEBUG (ScheduledTrigger-1503-thread-1) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 3 [junit4] 2> 342824 DEBUG (ScheduledTrigger-1503-thread-4) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger1 [junit4] 2> 342824 DEBUG (ScheduledTrigger-1503-thread-4) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 3 [junit4] 2> 342824 DEBUG (ScheduledTrigger-1503-thread-2) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeAddedTrigger Running NodeAddedTrigger node_added_trigger2 [junit4] 2> 342824 DEBUG (ScheduledTrigger-1503-thread-2) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeAddedTrigger Found livenodes: 3 [junit4] 2> 342824 DEBUG (ScheduledTrigger-1503-thread-4) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeAddedTrigger NodeAddedTrigger node_added_trigger1 firing registered processor for nodes: [127.0.0.1:58226_solr] added at times [2936279930504399], now=2936284942598901 [junit4] 2> 342824 DEBUG (ScheduledTrigger-1503-thread-4) [n:127.0.0.1:58100_solr ] o.a.s.c.a.ScheduledTriggers ++++++++ Cooldown inactive - processing event: { [junit4] 2> "id":"a6e87f23804cfT732ukvjnyoqcuvvfgi0hwiz99", [junit4] 2> "source":"node_added_trigger1", [junit4] 2> "eventTime":2936279930504399, [junit4] 2> "eventType":"NODEADDED", [junit4] 2> "properties":{ [junit4] 2> "eventTimes":[2936279930504399], [junit4] 2> "nodeNames":["127.0.0.1:58226_solr"]}} [junit4] 2> 342824 DEBUG (ScheduledTrigger-1503-thread-4) [n:127.0.0.1:58100_solr ] o.a.s.c.a.ScheduledTriggers Pausing all triggers: [.auto_add_replicas, node_added_trigger2, node_added_trigger1] [junit4] 2> 342825 DEBUG (AutoscalingActionExecutor-1504-thread-1-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.ScheduledTriggers -- processing actions for { [junit4] 2> "id":"a6e87f23804cfT732ukvjnyoqcuvvfgi0hwiz99", [junit4] 2> "source":"node_added_trigger1", [junit4] 2> "eventTime":2936279930504399, [junit4] 2> "eventType":"NODEADDED", [junit4] 2> "properties":{ [junit4] 2> "eventTimes":[2936279930504399], [junit4] 2> "_enqueue_time_":2936284942962419, [junit4] 2> "nodeNames":["127.0.0.1:58226_solr"]}} [junit4] 2> 342825 INFO (AutoscalingActionExecutor-1504-thread-1-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.TriggerIntegrationTest last action at 1519428048006000000 current time = 1519428053012000000 [junit4] 2> real diff: 5006000000 [junit4] 2> min diff: 4998000000 [junit4] 2> 342825 INFO (AutoscalingActionExecutor-1504-thread-1-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.TriggerIntegrationTest action executed from node_added_trigger1 [junit4] 2> 342827 DEBUG (AutoscalingActionExecutor-1504-thread-1-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.ScheduledTriggers Resuming trigger: .auto_add_replicas after 5000ms [junit4] 2> 342827 DEBUG (AutoscalingActionExecutor-1504-thread-1-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.ScheduledTriggers Resuming trigger: node_added_trigger2 after 5000ms [junit4] 2> 342827 DEBUG (AutoscalingActionExecutor-1504-thread-1-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.ScheduledTriggers Resuming trigger: node_added_trigger1 after 5000ms [junit4] 2> 342827 DEBUG (AutoscalingActionExecutor-1504-thread-1-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.ScheduledTriggers -- processing took 1 ms for event id=a6e87f23804cfT732ukvjnyoqcuvvfgi0hwiz99 [junit4] 2> 342831 INFO (qtp24431827-3042) [n:127.0.0.1:58100_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=1 [junit4] 2> 342834 INFO (qtp4875339-3113) [n:127.0.0.1:58211_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=1 [junit4] 2> 342840 INFO (qtp1650034-3135) [n:127.0.0.1:58226_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=1 [junit4] 2> 342841 DEBUG (qtp24431827-3039) [n:127.0.0.1:58100_solr ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration [junit4] 2> 342842 INFO (qtp24431827-3039) [n:127.0.0.1:58100_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/autoscaling params={wt=javabin&version=2} status=0 QTime=13 [junit4] 2> 342842 DEBUG (zkCallback-655-thread-2-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 6 [junit4] 2> 342843 DEBUG (zkCallback-655-thread-2-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeAddedTrigger Initial livenodes: [127.0.0.1:58211_solr, 127.0.0.1:58100_solr, 127.0.0.1:58226_solr] [junit4] 2> 342843 DEBUG (zkCallback-655-thread-2-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] 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.TriggerIntegrationTest$ThrottlingTesterAction}], enabled=true} [junit4] 2> 342843 DEBUG (zkCallback-655-thread-2-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:58211_solr, 127.0.0.1:58100_solr, 127.0.0.1:58226_solr] [junit4] 2> 342843 DEBUG (zkCallback-655-thread-2-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeAddedTrigger Initial livenodes: [127.0.0.1:58211_solr, 127.0.0.1:58100_solr, 127.0.0.1:58226_solr] [junit4] 2> 342843 DEBUG (zkCallback-655-thread-2-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] 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.TriggerIntegrationTest$ThrottlingTesterAction}], enabled=true} [junit4] 2> 342843 DEBUG (zkCallback-655-thread-2-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:58211_solr, 127.0.0.1:58100_solr, 127.0.0.1:58226_solr] [junit4] 2> 342844 DEBUG (OverseerAutoScalingTriggerThread-72250025578397700-127.0.0.1:58100_solr-n_0000000001) [n:127.0.0.1:58100_solr ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 6 [junit4] 2> 342846 INFO (OverseerAutoScalingTriggerThread-72250025578397700-127.0.0.1:58100_solr-n_0000000001) [n:127.0.0.1:58100_solr ] o.a.s.c.a.TriggerIntegrationTest TestTriggerAction init [junit4] 2> 342847 INFO (qtp24431827-3039) [n:127.0.0.1:58100_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=2 [junit4] 2> 342848 DEBUG (OverseerAutoScalingTriggerThread-72250025578397700-127.0.0.1:58100_solr-n_0000000001) [n:127.0.0.1:58100_solr ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 6, lastZnodeVersion 6 [junit4] 2> 342848 DEBUG (ScheduledTrigger-1503-thread-3) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: node_lost_trigger1 with currently live nodes: 3 [junit4] 2> 342851 INFO (qtp4875339-3114) [n:127.0.0.1:58211_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=1 [junit4] 2> 342853 INFO (qtp1650034-3141) [n:127.0.0.1:58226_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core} status=0 QTime=1 [junit4] 2> 342855 DEBUG (qtp4875339-3113) [n:127.0.0.1:58211_solr ] o.a.s.c.a.AutoScalingHandler Verified autoscaling configuration [junit4] 2> 342855 INFO (qtp4875339-3113) [n:127.0.0.1:58211_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/autoscaling params={wt=javabin&version=2} status=0 QTime=12 [junit4] 2> 342855 DEBUG (zkCallback-655-thread-2-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 7 [junit4] 2> 342856 DEBUG (zkCallback-655-thread-2-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeAddedTrigger Initial livenodes: [127.0.0.1:58211_solr, 127.0.0.1:58100_solr, 127.0.0.1:58226_solr] [junit4] 2> 342856 DEBUG (zkCallback-655-thread-2-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] 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.TriggerIntegrationTest$ThrottlingTesterAction}], enabled=true} [junit4] 2> 342856 DEBUG (zkCallback-655-thread-2-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:58211_solr, 127.0.0.1:58100_solr, 127.0.0.1:58226_solr] [junit4] 2> 342857 DEBUG (zkCallback-655-thread-2-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] o.a.s.c.a.NodeAddedTrigger Initial livenodes: [127.0.0.1:58211_solr, 127.0.0.1:58100_solr, 127.0.0.1:58226_solr] [junit4] 2> 342857 DEBUG (zkCallback-655-thread-2-processing-n:127.0.0.1:58100_solr) [n:127.0.0.1:58100_solr ] 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.TriggerIntegrationTest$ThrottlingTesterAction}], enabled=true} [junit4] 2> 342857 DEBUG (zkCallback-655-thread-2-processin [...truncated too long message...] yticsQueryTest, SubstringBytesRefFilterTest, TestStressRecovery, OverseerStatusTest, TestTlogReplica, TestSimDistributedQueue, TestSolrCoreSnapshots, SuggestComponentTest, DeleteStatusTest, TestLargeCluster, TestXmlQParser, PeerSyncReplicationTest, TestReRankQParserPlugin, PeerSyncWithIndexFingerprintCachingTest, TestCollationFieldDocValues, ExitableDirectoryReaderTest, TestSerializedLuceneMatchVersion, LIRRollingUpdatesTest, TestOrdValues, TestFieldSortValues, TestStressUserVersions, JsonLoaderTest, BasicDistributedZk2Test, TestStressReorder, TestSolr4Spatial2, QueryParsingTest, TestFieldCache, SimpleFacetsTest, AutoAddReplicasPlanActionTest, TestWriterPerf, FullSolrCloudDistribCmdsTest, HdfsChaosMonkeyNothingIsSafeTest, ResponseLogComponentTest, TestSQLHandlerNonCloud, ClusterStateTest, TestUnifiedSolrHighlighter, TestPayloadScoreQParserPlugin, QueryResultKeyTest, BufferStoreTest, AddBlockUpdateTest, DistributedSpellCheckComponentTest, DeleteLastCustomShardedReplicaTest, CustomHighlightComponentTest, MoveReplicaHDFSFailoverTest, DirectUpdateHandlerTest, CachingDirectoryFactoryTest, TestDFRSimilarityFactory, CollectionStateFormat2Test, ConcurrentDeleteAndCreateCollectionTest, DistributedFacetPivotWhiteBoxTest, SystemInfoHandlerTest, ZkSolrClientTest, NodeMutatorTest, HttpPartitionOnCommitTest, TestScoreJoinQPScore, TestFieldCollectionResource, TestBlobHandler, XsltUpdateRequestHandlerTest, SpellPossibilityIteratorTest, CdcrUpdateLogTest, ScriptEngineTest, ShowFileRequestHandlerTest, TestSolrIndexConfig, TestSizeLimitedDistributedMap, TestCollapseQParserPlugin, HighlighterConfigTest, TestValueSourceCache, DistributedQueueTest, TestCrossCoreJoin, TestJsonFacets, BasicFunctionalityTest, HLLSerializationTest, SpatialHeatmapFacetsTest, TestRandomDVFaceting, TestBulkSchemaAPI] [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestBulkSchemaAPI -Dtests.seed=A32C490431C1F1C2 -Dtests.slow=true -Dtests.locale=es-PE -Dtests.timezone=Asia/Kathmandu -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 0.00s J1 | TestBulkSchemaAPI (suite) <<< [junit4] > Throwable #1: com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.rest.schema.TestBulkSchemaAPI: [junit4] > 1) Thread[id=12013, name=qtp19872476-12013, state=TIMED_WAITING, group=TGRP-TestBulkSchemaAPI] [junit4] > at sun.misc.Unsafe.park(Native Method) [junit4] > at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) [junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163) [junit4] > at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308) [junit4] > at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373) [junit4] > at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708) [junit4] > at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626) [junit4] > at java.lang.Thread.run(Thread.java:748) [junit4] > at __randomizedtesting.SeedInfo.seed([A32C490431C1F1C2]:0)Throwable #2: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated: [junit4] > 1) Thread[id=12013, name=qtp19872476-12013, state=TIMED_WAITING, group=TGRP-TestBulkSchemaAPI] [junit4] > at sun.misc.Unsafe.park(Native Method) [junit4] > at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) [junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163) [junit4] > at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308) [junit4] > at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373) [junit4] > at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708) [junit4] > at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626) [junit4] > at java.lang.Thread.run(Thread.java:748) [junit4] > at __randomizedtesting.SeedInfo.seed([A32C490431C1F1C2]:0) [junit4] Completed [280/777 (3!)] on J1 in 98.59s, 10 tests, 2 errors <<< FAILURES! [...truncated 3991 lines...] [junit4] Suite: org.apache.solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory [junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\init-core-data-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=1294, maxMBSortInHeap=7.981586594514307, sim=RandomSimilarity(queryNorm=true): {}, locale=el-CY, timezone=Asia/Urumqi [junit4] 2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_144 (32-bit)/cpus=3,threads=1,free=12950296,total=42663936 [junit4] 2> NOTE: All tests run in this JVM: [TestFoldingMultitermExtrasQuery, TestICUCollationFieldOptions, TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory] [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory -Dtests.seed=1C7690B804FAC724 -Dtests.slow=true -Dtests.locale=el-CY -Dtests.timezone=Asia/Urumqi -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [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-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1\conf: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1\conf [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1 [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001 [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1\conf\en-test-tokenizer.bin: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1\conf\en-test-tokenizer.bin [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1\conf\en-test-ner-person.bin: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1\conf\en-test-ner-person.bin [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1\conf\en-test-sent.bin: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001\tempDir-001\collection1\conf\en-test-sent.bin [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_1C7690B804FAC724-001 [junit4] > at __randomizedtesting.SeedInfo.seed([1C7690B804FAC724]:0) [junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329) [junit4] > at java.lang.Thread.run(Thread.java:748) [junit4] Completed [5/5 (1!)] on J1 in 1.15s, 8 tests, 1 error <<< FAILURES! [...truncated 43379 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org