Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/7205/ Java: 64bit/jdk1.8.0_144 -XX:+UseCompressedOops -XX:+UseG1GC
5 tests failed. FAILED: junit.framework.TestSuite.org.apache.lucene.store.TestFileSwitchDirectory Error Message: Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\core\test\J1\temp\lucene.store.TestFileSwitchDirectory_2D3C5A5B0EEAF5F6-001\bar-005: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\core\test\J1\temp\lucene.store.TestFileSwitchDirectory_2D3C5A5B0EEAF5F6-001\bar-005 C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\core\test\J1\temp\lucene.store.TestFileSwitchDirectory_2D3C5A5B0EEAF5F6-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\core\test\J1\temp\lucene.store.TestFileSwitchDirectory_2D3C5A5B0EEAF5F6-001 Stack Trace: java.io.IOException: Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\core\test\J1\temp\lucene.store.TestFileSwitchDirectory_2D3C5A5B0EEAF5F6-001\bar-005: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\core\test\J1\temp\lucene.store.TestFileSwitchDirectory_2D3C5A5B0EEAF5F6-001\bar-005 C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\core\test\J1\temp\lucene.store.TestFileSwitchDirectory_2D3C5A5B0EEAF5F6-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\core\test\J1\temp\lucene.store.TestFileSwitchDirectory_2D3C5A5B0EEAF5F6-001 at __randomizedtesting.SeedInfo.seed([2D3C5A5B0EEAF5F6]: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.lucene.replicator.http.HttpReplicatorTest.testBasic Error Message: Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\replicator\test\J0\temp\lucene.replicator.http.HttpReplicatorTest_E725F21B37EF101D-001\httpReplicatorTest-001\2\index: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\replicator\test\J0\temp\lucene.replicator.http.HttpReplicatorTest_E725F21B37EF101D-001\httpReplicatorTest-001\2\index C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\replicator\test\J0\temp\lucene.replicator.http.HttpReplicatorTest_E725F21B37EF101D-001\httpReplicatorTest-001\2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\replicator\test\J0\temp\lucene.replicator.http.HttpReplicatorTest_E725F21B37EF101D-001\httpReplicatorTest-001\2 Stack Trace: java.io.IOException: Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\replicator\test\J0\temp\lucene.replicator.http.HttpReplicatorTest_E725F21B37EF101D-001\httpReplicatorTest-001\2\index: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\replicator\test\J0\temp\lucene.replicator.http.HttpReplicatorTest_E725F21B37EF101D-001\httpReplicatorTest-001\2\index C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\replicator\test\J0\temp\lucene.replicator.http.HttpReplicatorTest_E725F21B37EF101D-001\httpReplicatorTest-001\2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\replicator\test\J0\temp\lucene.replicator.http.HttpReplicatorTest_E725F21B37EF101D-001\httpReplicatorTest-001\2 at __randomizedtesting.SeedInfo.seed([E725F21B37EF101D:4CDFEF0EE8339633]:0) at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329) at org.apache.lucene.replicator.PerSessionDirectoryFactory.cleanupSession(PerSessionDirectoryFactory.java:58) at org.apache.lucene.replicator.ReplicationClient.doUpdate(ReplicationClient.java:259) at org.apache.lucene.replicator.ReplicationClient.updateNow(ReplicationClient.java:401) at org.apache.lucene.replicator.http.HttpReplicatorTest.testBasic(HttpReplicatorTest.java:121) 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 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 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.cloud.TriLevelCompositeIdRoutingTest Error Message: Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\shard-2-001\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\shard-2-001\collection1 C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\shard-2-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\shard-2-001 Stack Trace: java.io.IOException: Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\shard-2-001\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\shard-2-001\collection1 C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\shard-2-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\shard-2-001 at __randomizedtesting.SeedInfo.seed([66ECA2EF096B57D7]: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: junit.framework.TestSuite.org.apache.solr.core.TestSolrConfigHandler Error Message: Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.core.TestSolrConfigHandler_66ECA2EF096B57D7-001\tempDir-010\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.core.TestSolrConfigHandler_66ECA2EF096B57D7-001\tempDir-010\collection1 C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.core.TestSolrConfigHandler_66ECA2EF096B57D7-001\tempDir-010: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.core.TestSolrConfigHandler_66ECA2EF096B57D7-001\tempDir-010 Stack Trace: java.io.IOException: Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.core.TestSolrConfigHandler_66ECA2EF096B57D7-001\tempDir-010\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.core.TestSolrConfigHandler_66ECA2EF096B57D7-001\tempDir-010\collection1 C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.core.TestSolrConfigHandler_66ECA2EF096B57D7-001\tempDir-010: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.core.TestSolrConfigHandler_66ECA2EF096B57D7-001\tempDir-010 at __randomizedtesting.SeedInfo.seed([66ECA2EF096B57D7]: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: junit.framework.TestSuite.org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest Error Message: Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedQueryComponentCustomSortTest_66ECA2EF096B57D7-001\tempDir-001\shard2\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedQueryComponentCustomSortTest_66ECA2EF096B57D7-001\tempDir-001\shard2\collection1 C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedQueryComponentCustomSortTest_66ECA2EF096B57D7-001\tempDir-001\shard2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedQueryComponentCustomSortTest_66ECA2EF096B57D7-001\tempDir-001\shard2 C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedQueryComponentCustomSortTest_66ECA2EF096B57D7-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedQueryComponentCustomSortTest_66ECA2EF096B57D7-001\tempDir-001 Stack Trace: java.io.IOException: Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedQueryComponentCustomSortTest_66ECA2EF096B57D7-001\tempDir-001\shard2\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedQueryComponentCustomSortTest_66ECA2EF096B57D7-001\tempDir-001\shard2\collection1 C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedQueryComponentCustomSortTest_66ECA2EF096B57D7-001\tempDir-001\shard2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedQueryComponentCustomSortTest_66ECA2EF096B57D7-001\tempDir-001\shard2 C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedQueryComponentCustomSortTest_66ECA2EF096B57D7-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedQueryComponentCustomSortTest_66ECA2EF096B57D7-001\tempDir-001 at __randomizedtesting.SeedInfo.seed([66ECA2EF096B57D7]: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 848 lines...] [junit4] Suite: org.apache.lucene.store.TestFileSwitchDirectory [junit4] IGNOR/A 0.02s J1 | TestFileSwitchDirectory.testFsyncDoesntCreateNewFiles [junit4] > Assumption #1: test only works for FSDirectory subclasses [junit4] IGNOR/A 0.01s J1 | TestFileSwitchDirectory.testPendingDeletions [junit4] > Assumption #1: we can only install VirusCheckingFS on an FSDirectory [junit4] 2> NOTE: test params are: codec=Lucene70, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@4d01e342), locale=es, timezone=America/Araguaina [junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 1.8.0_144 (64-bit)/cpus=3,threads=1,free=324223080,total=497025024 [junit4] 2> NOTE: All tests run in this JVM: [TestLongRangeFieldQueries, TestLogMergePolicy, TestAxiomaticSimilarity, TestExceedMaxTermLength, TestFuzzyQuery, TestBytesStore, TestRateLimiter, TestSearcherManager, TestConjunctionDISI, TestLucene50StoredFieldsFormat, TestPrefixInBooleanQuery, Test2BPostings, TestConstantScoreQuery, TestPackedInts, TestStressDeletes, TestDocsWithFieldSet, TestIndexWriterCommit, TestAxiomaticF3EXP, TestSortRandom, TestCharTermAttributeImpl, TestSortedSetSortField, TestLSBRadixSorter, TestFieldType, TestMultiTermsEnum, TestFilterCodecReader, TestRegexpRandom, TestRollingBuffer, TestParallelTermEnum, TestIntroSelector, TestSparseFixedBitSet, Test4GBStoredFields, TestDemoParallelLeafReader, TestLucene50TermVectorsFormat, TestMergedIterator, TestPersistentSnapshotDeletionPolicy, TestTimSorterWorstCase, TestBytesRefHash, TestIndependenceChiSquared, TestIndexWriterForceMerge, TestDoubleRangeFieldQueries, TestUsageTrackingFilterCachingPolicy, TestGraphTokenizers, Test2BDocs, TestBytesRefAttImpl, TestSetOnce, TestPolygon, TestBufferedChecksum, TestOperations, Test2BPoints, TestIsCurrent, TestMaxTermFrequency, TestSpanContainQuery, TestConcurrentMergeScheduler, TestSpanBoostQuery, TestDelegatingAnalyzerWrapper, TestShardSearching, TestForUtil, TestComplexExplanationsOfNonMatches, TestTransactions, TestNumericUtils, Test2BSortedDocValuesOrds, TestPagedBytes, TestDocIdsWriter, TestIndexingSequenceNumbers, TestDistributionLL, Test2BPositions, TestCustomSearcherSort, TestIndexWriterReader, TestIndexWriterOutOfFileDescriptors, TestIndexReaderClose, TestBlockPostingsFormat2, TestTerm, TestTerms, TestMatchNoDocsQuery, TestBoolean2, TestAxiomaticF2EXP, TestDirectoryReaderReopen, TestSpanTermQuery, TestApproximationSearchEquivalence, TestLongPostings, TestDateTools, TestPerFieldPostingsFormat2, TestPayloadsOnVectors, TestFastDecompressionMode, TestFixedBitSet, TestPositionIncrement, TestIndexOrDocValuesQuery, TestAutomatonQuery, TestStopFilter, TestSimpleSearchEquivalence, TestMultiCollector, TestFastCompressionMode, TestByteArrayDataInput, TestSearchAfter, TestSearchForDuplicates, LimitedFiniteStringsIteratorTest, TestSizeBoundedForceMerge, Test2BBKDPoints, TestFileSwitchDirectory] [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestFileSwitchDirectory -Dtests.seed=2D3C5A5B0EEAF5F6 -Dtests.slow=true -Dtests.locale=es -Dtests.timezone=America/Araguaina -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [junit4] ERROR 0.00s J1 | TestFileSwitchDirectory (suite) <<< [junit4] > Throwable #1: java.io.IOException: Could not remove the following files (in the order of attempts): [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\core\test\J1\temp\lucene.store.TestFileSwitchDirectory_2D3C5A5B0EEAF5F6-001\bar-005: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\core\test\J1\temp\lucene.store.TestFileSwitchDirectory_2D3C5A5B0EEAF5F6-001\bar-005 [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\core\test\J1\temp\lucene.store.TestFileSwitchDirectory_2D3C5A5B0EEAF5F6-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\core\test\J1\temp\lucene.store.TestFileSwitchDirectory_2D3C5A5B0EEAF5F6-001 [junit4] > at __randomizedtesting.SeedInfo.seed([2D3C5A5B0EEAF5F6]:0) [junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329) [junit4] > at java.lang.Thread.run(Thread.java:748) [junit4] Completed [187/486 (1!)] on J1 in 2.62s, 43 tests, 1 error, 2 skipped <<< FAILURES! [...truncated 8345 lines...] [junit4] Suite: org.apache.lucene.replicator.http.HttpReplicatorTest [junit4] 2> 2018-03-06 21:52:39.453:INFO::TEST-HttpReplicatorTest.testBasic-seed#[E725F21B37EF101D]: Logging initialized @2100ms to org.eclipse.jetty.util.log.StdErrLog [junit4] 2> 2018-03-06 21:52:39.612:INFO:oejs.Server:TEST-HttpReplicatorTest.testBasic-seed#[E725F21B37EF101D]: jetty-9.4.8.v20171121, build timestamp: 2017-11-21T22:27:37+01:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 2018-03-06 21:52:39.646:INFO:oejs.session:TEST-HttpReplicatorTest.testBasic-seed#[E725F21B37EF101D]: DefaultSessionIdManager workerName=node0 [junit4] 2> 2018-03-06 21:52:39.646:INFO:oejs.session:TEST-HttpReplicatorTest.testBasic-seed#[E725F21B37EF101D]: No SessionScavenger set, using defaults [junit4] 2> 2018-03-06 21:52:39.651:INFO:oejs.session:TEST-HttpReplicatorTest.testBasic-seed#[E725F21B37EF101D]: Scavenging every 600000ms [junit4] 2> 2018-03-06 21:52:44.762:INFO:oejs.AbstractConnector:TEST-HttpReplicatorTest.testBasic-seed#[E725F21B37EF101D]: Started ServerConnector@c1acd36{HTTP/1.1,[http/1.1]}{127.0.0.1:50011} [junit4] 2> 2018-03-06 21:52:44.764:INFO:oejs.Server:TEST-HttpReplicatorTest.testBasic-seed#[E725F21B37EF101D]: Started @7411ms [junit4] 2> 2018-03-06 21:52:45.480:INFO:oejs.AbstractConnector:TEST-HttpReplicatorTest.testBasic-seed#[E725F21B37EF101D]: Stopped ServerConnector@c1acd36{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 2018-03-06 21:52:45.482:INFO:oejs.session:TEST-HttpReplicatorTest.testBasic-seed#[E725F21B37EF101D]: Stopped scavenging [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=HttpReplicatorTest -Dtests.method=testBasic -Dtests.seed=E725F21B37EF101D -Dtests.slow=true -Dtests.locale=de -Dtests.timezone=Europe/Busingen -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [junit4] ERROR 6.08s J0 | HttpReplicatorTest.testBasic <<< [junit4] > Throwable #1: java.io.IOException: Could not remove the following files (in the order of attempts): [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\replicator\test\J0\temp\lucene.replicator.http.HttpReplicatorTest_E725F21B37EF101D-001\httpReplicatorTest-001\2\index: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\replicator\test\J0\temp\lucene.replicator.http.HttpReplicatorTest_E725F21B37EF101D-001\httpReplicatorTest-001\2\index [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\replicator\test\J0\temp\lucene.replicator.http.HttpReplicatorTest_E725F21B37EF101D-001\httpReplicatorTest-001\2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\replicator\test\J0\temp\lucene.replicator.http.HttpReplicatorTest_E725F21B37EF101D-001\httpReplicatorTest-001\2 [junit4] > at __randomizedtesting.SeedInfo.seed([E725F21B37EF101D:4CDFEF0EE8339633]:0) [junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329) [junit4] > at org.apache.lucene.replicator.PerSessionDirectoryFactory.cleanupSession(PerSessionDirectoryFactory.java:58) [junit4] > at org.apache.lucene.replicator.ReplicationClient.doUpdate(ReplicationClient.java:259) [junit4] > at org.apache.lucene.replicator.ReplicationClient.updateNow(ReplicationClient.java:401) [junit4] > at org.apache.lucene.replicator.http.HttpReplicatorTest.testBasic(HttpReplicatorTest.java:121) [junit4] > at java.lang.Thread.run(Thread.java:748) [junit4] 2> 2018-03-06 21:52:45.500:INFO:oejs.Server:TEST-HttpReplicatorTest.testServerErrors-seed#[E725F21B37EF101D]: jetty-9.4.8.v20171121, build timestamp: 2017-11-21T22:27:37+01:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 2018-03-06 21:52:45.501:INFO:oejs.session:TEST-HttpReplicatorTest.testServerErrors-seed#[E725F21B37EF101D]: DefaultSessionIdManager workerName=node0 [junit4] 2> 2018-03-06 21:52:45.501:INFO:oejs.session:TEST-HttpReplicatorTest.testServerErrors-seed#[E725F21B37EF101D]: No SessionScavenger set, using defaults [junit4] 2> 2018-03-06 21:52:45.501:INFO:oejs.session:TEST-HttpReplicatorTest.testServerErrors-seed#[E725F21B37EF101D]: Scavenging every 600000ms [junit4] 2> 2018-03-06 21:52:45.502:INFO:oejs.AbstractConnector:TEST-HttpReplicatorTest.testServerErrors-seed#[E725F21B37EF101D]: Started ServerConnector@4f935f00{HTTP/1.1,[http/1.1]}{127.0.0.1:50015} [junit4] 2> 2018-03-06 21:52:45.502:INFO:oejs.Server:TEST-HttpReplicatorTest.testServerErrors-seed#[E725F21B37EF101D]: Started @8150ms [junit4] 2> 2018-03-06 21:52:45.553:INFO:oejs.AbstractConnector:TEST-HttpReplicatorTest.testServerErrors-seed#[E725F21B37EF101D]: Stopped ServerConnector@4f935f00{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 2018-03-06 21:52:45.553:INFO:oejs.session:TEST-HttpReplicatorTest.testServerErrors-seed#[E725F21B37EF101D]: Stopped scavenging [junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\build\replicator\test\J0\temp\lucene.replicator.http.HttpReplicatorTest_E725F21B37EF101D-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=939, maxMBSortInHeap=5.158303769696678, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@4de9b202), locale=de, timezone=Europe/Busingen [junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 1.8.0_144 (64-bit)/cpus=3,threads=1,free=48013168,total=100663296 [junit4] 2> NOTE: All tests run in this JVM: [TestStressNRTReplication, LocalReplicatorTest, HttpReplicatorTest] [junit4] Completed [6/9 (1!)] on J0 in 6.17s, 2 tests, 1 error <<< FAILURES! [...truncated 4824 lines...] [junit4] Suite: org.apache.solr.cloud.TriLevelCompositeIdRoutingTest [junit4] 2> 2355440 INFO (SUITE-TriLevelCompositeIdRoutingTest-seed#[66ECA2EF096B57D7]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\init-core-data-001 [junit4] 2> 2355445 WARN (SUITE-TriLevelCompositeIdRoutingTest-seed#[66ECA2EF096B57D7]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=541 numCloses=541 [junit4] 2> 2355446 INFO (SUITE-TriLevelCompositeIdRoutingTest-seed#[66ECA2EF096B57D7]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 2355454 INFO (SUITE-TriLevelCompositeIdRoutingTest-seed#[66ECA2EF096B57D7]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN) [junit4] 2> 2355454 INFO (SUITE-TriLevelCompositeIdRoutingTest-seed#[66ECA2EF096B57D7]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /adp/f [junit4] 2> 2355459 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 2355460 INFO (Thread-4921) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 2355460 INFO (Thread-4921) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 2355465 ERROR (Thread-4921) [ ] 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> 2355560 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.ZkTestServer start zk server on port:53938 [junit4] 2> 2355610 INFO (zkConnectionManagerCallback-6229-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2355613 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 0x1001c4910d80000, likely client has closed socket [junit4] 2> 2355617 INFO (zkConnectionManagerCallback-6231-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2355618 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.AbstractZkTestCase put C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig-tlog.xml to /configs/conf1/solrconfig.xml [junit4] 2> 2355618 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.AbstractZkTestCase put C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1\conf\schema15.xml to /configs/conf1/schema.xml [junit4] 2> 2355631 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.AbstractZkTestCase put C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 2355634 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.AbstractZkTestCase put C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1\conf\stopwords.txt to /configs/conf1/stopwords.txt [junit4] 2> 2355635 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.AbstractZkTestCase put C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1\conf\protwords.txt to /configs/conf1/protwords.txt [junit4] 2> 2355635 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.AbstractZkTestCase put C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1\conf\currency.xml to /configs/conf1/currency.xml [junit4] 2> 2355635 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.AbstractZkTestCase put C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1\conf\enumsConfig.xml to /configs/conf1/enumsConfig.xml [junit4] 2> 2355641 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.AbstractZkTestCase put C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1\conf\open-exchange-rates.json to /configs/conf1/open-exchange-rates.json [junit4] 2> 2355643 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.AbstractZkTestCase put C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1\conf\mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 2355644 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.AbstractZkTestCase put C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1\conf\old_synonyms.txt to /configs/conf1/old_synonyms.txt [junit4] 2> 2355646 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.AbstractZkTestCase put C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1\conf\synonyms.txt to /configs/conf1/synonyms.txt [junit4] 2> 2355648 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Will use NRT replicas unless explicitly asked otherwise [junit4] 2> 2357254 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T22:27:37+01:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 2357254 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 2357254 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2357255 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.e.j.s.session Scavenging every 660000ms [junit4] 2> 2357255 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@28f2d1e0{/adp/f,null,AVAILABLE} [junit4] 2> 2357256 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@380054ef{HTTP/1.1,[http/1.1]}{127.0.0.1:53945} [junit4] 2> 2357257 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.e.j.s.Server Started @2365955ms [junit4] 2> 2357257 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\tempDir-001/control/data, hostContext=/adp/f, hostPort=53945, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\control-001\cores} [junit4] 2> 2357258 ERROR (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2357258 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0 [junit4] 2> 2357258 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2357258 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2357258 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-06T21:34:59.905Z [junit4] 2> 2357261 INFO (zkConnectionManagerCallback-6233-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2357264 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 2357264 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\control-001\solr.xml [junit4] 2> 2357283 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 2357283 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 2357284 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@76c1868d, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 2357290 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:53938/solr [junit4] 2> 2357296 INFO (zkConnectionManagerCallback-6237-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2357297 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 0x1001c4910d80003, likely client has closed socket [junit4] 2> 2357303 INFO (zkConnectionManagerCallback-6239-thread-1-processing-n:127.0.0.1:53945_adp%2Ff) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2357406 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2357411 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:53945_adp%2Ff [junit4] 2> 2357412 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.c.Overseer Overseer (id=72088694178709508-127.0.0.1:53945_adp%2Ff-n_0000000000) starting [junit4] 2> 2357418 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:53945_adp%2Ff [junit4] 2> 2357430 INFO (OverseerStateUpdate-72088694178709508-127.0.0.1:53945_adp%2Ff-n_0000000000) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 2357528 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@76c1868d [junit4] 2> 2357601 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@76c1868d [junit4] 2> 2357602 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@76c1868d [junit4] 2> 2357604 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\control-001\cores [junit4] 2> 2357644 INFO (zkConnectionManagerCallback-6245-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2357646 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 2357647 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:53938/solr ready [junit4] 2> 2357650 INFO (qtp1938830154-24442) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=1&collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:53945_adp%252Ff&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 2357653 INFO (OverseerThreadFactory-9311-thread-1-processing-n:127.0.0.1:53945_adp%2Ff) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.c.a.c.CreateCollectionCmd Create collection control_collection [junit4] 2> 2357773 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT [junit4] 2> 2357775 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 2357883 INFO (zkCallback-6238-thread-1-processing-n:127.0.0.1:53945_adp%2Ff) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1]) [junit4] 2> 2358818 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 2358839 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.s.IndexSchema [control_collection_shard1_replica_n1] Schema name=test [junit4] 2> 2359027 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id [junit4] 2> 2359061 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'control_collection_shard1_replica_n1' using configuration from collection control_collection, trusted=true [junit4] 2> 2359061 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.control_collection.shard1.replica_n1' (registry 'solr.core.control_collection.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@76c1868d [junit4] 2> 2359061 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 2359062 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.c.SolrCore [[control_collection_shard1_replica_n1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\control-001\cores\control_collection_shard1_replica_n1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\control-001\cores\control_collection_shard1_replica_n1\data\] [junit4] 2> 2359070 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=22, maxMergeAtOnceExplicit=35, maxMergedSegmentMB=40.830078125, floorSegmentMB=0.8603515625, forceMergeDeletesPctAllowed=27.020388044893384, segmentsPerTier=27.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0 [junit4] 2> 2359155 WARN (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}} [junit4] 2> 2359291 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2359291 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 2359293 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2359294 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2359295 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=20, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 2359300 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@19a7b72a[control_collection_shard1_replica_n1] main] [junit4] 2> 2359303 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 2359304 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 2359305 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 2359308 INFO (searcherExecutor-9314-thread-1-processing-n:127.0.0.1:53945_adp%2Ff x:control_collection_shard1_replica_n1 s:shard1 c:control_collection) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.c.SolrCore [control_collection_shard1_replica_n1] Registered new searcher Searcher@19a7b72a[control_collection_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2359309 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1594225697180614656 [junit4] 2> 2359363 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.c.ZkShardTerms Successful update terms at /collections/control_collection/terms/shard1 to Terms{values={core_node2=0}, version=0} [junit4] 2> 2359366 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 2359366 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 2359366 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:53945/adp/f/control_collection_shard1_replica_n1/ [junit4] 2> 2359366 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 2359366 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.c.SyncStrategy http://127.0.0.1:53945/adp/f/control_collection_shard1_replica_n1/ has no replicas [junit4] 2> 2359366 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 2359370 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:53945/adp/f/control_collection_shard1_replica_n1/ shard1 [junit4] 2> 2359473 INFO (zkCallback-6238-thread-2-processing-n:127.0.0.1:53945_adp%2Ff) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1]) [junit4] 2> 2359522 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 2359527 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1753 [junit4] 2> 2359535 INFO (qtp1938830154-24442) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 30 seconds. Check all shard replicas [junit4] 2> 2359632 INFO (zkCallback-6238-thread-2-processing-n:127.0.0.1:53945_adp%2Ff) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1]) [junit4] 2> 2359655 INFO (OverseerCollectionConfigSetProcessor-72088694178709508-127.0.0.1:53945_adp%2Ff-n_0000000000) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 2360537 INFO (qtp1938830154-24442) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={replicationFactor=1&collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:53945_adp%252Ff&wt=javabin&version=2} status=0 QTime=2887 [junit4] 2> 2360538 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 0x1001c4910d80005, likely client has closed socket [junit4] 2> 2360546 INFO (zkConnectionManagerCallback-6249-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2360547 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 2360548 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:53938/solr ready [junit4] 2> 2360548 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false [junit4] 2> 2360550 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=1&collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=&stateFormat=1&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 2360555 INFO (OverseerThreadFactory-9311-thread-2-processing-n:127.0.0.1:53945_adp%2Ff) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.c.a.c.CreateCollectionCmd Create collection collection1 [junit4] 2> 2360556 WARN (OverseerThreadFactory-9311-thread-2-processing-n:127.0.0.1:53945_adp%2Ff) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.c.a.c.CreateCollectionCmd It is unusual to create a collection (collection1) without cores. [junit4] 2> 2360772 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 30 seconds. Check all shard replicas [junit4] 2> 2360772 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={replicationFactor=1&collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=&stateFormat=1&wt=javabin&version=2} status=0 QTime=222 [junit4] 2> 2360774 INFO (OverseerCollectionConfigSetProcessor-72088694178709508-127.0.0.1:53945_adp%2Ff-n_0000000000) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 2362263 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\shard-1-001 of type NRT [junit4] 2> 2362265 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T22:27:37+01:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 2362266 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 2362266 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2362266 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.e.j.s.session Scavenging every 600000ms [junit4] 2> 2362267 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3e662987{/adp/f,null,AVAILABLE} [junit4] 2> 2362272 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@4bec483f{HTTP/1.1,[http/1.1]}{127.0.0.1:53966} [junit4] 2> 2362272 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.e.j.s.Server Started @2370970ms [junit4] 2> 2362272 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\tempDir-001/jetty1, solrconfig=solrconfig.xml, hostContext=/adp/f, hostPort=53966, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\..\..\..\..\..\..\..\..\..\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\shard-1-001\cores} [junit4] 2> 2362273 ERROR (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2362273 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0 [junit4] 2> 2362273 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2362273 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2362273 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-06T21:35:04.920Z [junit4] 2> 2362277 INFO (zkConnectionManagerCallback-6251-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2362282 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 2362282 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\shard-1-001\solr.xml [junit4] 2> 2362295 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 2362295 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 2362296 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@76c1868d, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 2362320 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:53938/solr [junit4] 2> 2362325 INFO (zkConnectionManagerCallback-6255-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2362326 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 0x1001c4910d80008, likely client has closed socket [junit4] 2> 2362330 INFO (zkConnectionManagerCallback-6257-thread-1-processing-n:127.0.0.1:53966_adp%2Ff) [n:127.0.0.1:53966_adp%2Ff ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2362351 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [n:127.0.0.1:53966_adp%2Ff ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 2362351 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [n:127.0.0.1:53966_adp%2Ff ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2362351 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [n:127.0.0.1:53966_adp%2Ff ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:53966_adp%2Ff [junit4] 2> 2362368 INFO (zkCallback-6248-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 2362368 INFO (zkCallback-6238-thread-2-processing-n:127.0.0.1:53945_adp%2Ff) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 2362370 INFO (zkCallback-6256-thread-1-processing-n:127.0.0.1:53966_adp%2Ff) [n:127.0.0.1:53966_adp%2Ff ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 2362779 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [n:127.0.0.1:53966_adp%2Ff ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@76c1868d [junit4] 2> 2362815 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [n:127.0.0.1:53966_adp%2Ff ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@76c1868d [junit4] 2> 2362816 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [n:127.0.0.1:53966_adp%2Ff ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@76c1868d [junit4] 2> 2362820 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [n:127.0.0.1:53966_adp%2Ff ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\..\..\..\..\..\..\..\..\..\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\shard-1-001\cores [junit4] 2> 2362925 INFO (qtp1938830154-24448) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params node=127.0.0.1:53966_adp%252Ff&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 2362931 INFO (OverseerThreadFactory-9311-thread-3-processing-n:127.0.0.1:53945_adp%2Ff) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.c.a.c.AddReplicaCmd Node Identified 127.0.0.1:53966_adp%2Ff for creating new replica [junit4] 2> 2362936 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_n41&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT [junit4] 2> 2362937 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 2364042 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 2364061 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.s.IndexSchema [collection1_shard2_replica_n41] Schema name=test [junit4] 2> 2364127 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id [junit4] 2> 2364206 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard2_replica_n41' using configuration from collection collection1, trusted=true [junit4] 2> 2364208 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1.shard2.replica_n41' (registry 'solr.core.collection1.shard2.replica_n41') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@76c1868d [junit4] 2> 2364208 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 2364208 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.SolrCore [[collection1_shard2_replica_n41] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\shard-1-001\cores\collection1_shard2_replica_n41], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\..\..\..\..\..\..\..\..\..\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\shard-1-001\cores\collection1_shard2_replica_n41\data\] [junit4] 2> 2364220 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=22, maxMergeAtOnceExplicit=35, maxMergedSegmentMB=40.830078125, floorSegmentMB=0.8603515625, forceMergeDeletesPctAllowed=27.020388044893384, segmentsPerTier=27.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0 [junit4] 2> 2364296 WARN (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}} [junit4] 2> 2364434 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2364434 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 2364436 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2364437 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2364438 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=20, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 2364439 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.s.SolrIndexSearcher Opening [Searcher@6b61e95d[collection1_shard2_replica_n41] main] [junit4] 2> 2364441 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 2364441 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 2364442 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 2364444 INFO (searcherExecutor-9325-thread-1-processing-n:127.0.0.1:53966_adp%2Ff x:collection1_shard2_replica_n41 s:shard2 c:collection1) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.SolrCore [collection1_shard2_replica_n41] Registered new searcher Searcher@6b61e95d[collection1_shard2_replica_n41] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2364444 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1594225702565052416 [junit4] 2> 2364449 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.ZkShardTerms Successful update terms at /collections/collection1/terms/shard2 to Terms{values={core_node42=0}, version=0} [junit4] 2> 2364452 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 2364452 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 2364452 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:53966/adp/f/collection1_shard2_replica_n41/ [junit4] 2> 2364452 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 2364452 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.SyncStrategy http://127.0.0.1:53966/adp/f/collection1_shard2_replica_n41/ has no replicas [junit4] 2> 2364452 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 2364456 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:53966/adp/f/collection1_shard2_replica_n41/ shard2 [junit4] 2> 2364561 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 2364565 INFO (qtp2129804281-24494) [n:127.0.0.1:53966_adp%2Ff c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_n41&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1629 [junit4] 2> 2364567 INFO (qtp1938830154-24448) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={node=127.0.0.1:53966_adp%252Ff&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2} status=0 QTime=1642 [junit4] 2> 2364931 INFO (OverseerCollectionConfigSetProcessor-72088694178709508-127.0.0.1:53945_adp%2Ff-n_0000000000) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000004 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 2365530 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\shard-2-001 of type NRT [junit4] 2> 2365532 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T22:27:37+01:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 2365533 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 2365533 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2365533 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.e.j.s.session Scavenging every 660000ms [junit4] 2> 2365534 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@46d29fd2{/adp/f,null,AVAILABLE} [junit4] 2> 2365534 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@15b4724f{HTTP/1.1,[http/1.1]}{127.0.0.1:53979} [junit4] 2> 2365534 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.e.j.s.Server Started @2374233ms [junit4] 2> 2365534 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\tempDir-001/jetty2, solrconfig=solrconfig.xml, hostContext=/adp/f, hostPort=53979, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\..\..\..\..\..\..\..\..\..\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\shard-2-001\cores} [junit4] 2> 2365540 ERROR (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2365542 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0 [junit4] 2> 2365542 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 2365542 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2365543 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-06T21:35:08.189Z [junit4] 2> 2365555 INFO (zkConnectionManagerCallback-6261-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2365559 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 2365559 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\shard-2-001\solr.xml [junit4] 2> 2365580 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 2365580 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 2365581 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@76c1868d, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 2365588 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:53938/solr [junit4] 2> 2365591 INFO (zkConnectionManagerCallback-6265-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2365591 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 0x1001c4910d8000b, likely client has closed socket [junit4] 2> 2365596 INFO (zkConnectionManagerCallback-6267-thread-1-processing-n:127.0.0.1:53979_adp%2Ff) [n:127.0.0.1:53979_adp%2Ff ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 2365602 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [n:127.0.0.1:53979_adp%2Ff ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 2365605 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [n:127.0.0.1:53979_adp%2Ff ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2365607 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [n:127.0.0.1:53979_adp%2Ff ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:53979_adp%2Ff [junit4] 2> 2365609 INFO (zkCallback-6256-thread-1-processing-n:127.0.0.1:53966_adp%2Ff) [n:127.0.0.1:53966_adp%2Ff ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 2365610 INFO (zkCallback-6238-thread-2-processing-n:127.0.0.1:53945_adp%2Ff) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 2365610 INFO (zkCallback-6248-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 2365615 INFO (zkCallback-6266-thread-1-processing-n:127.0.0.1:53979_adp%2Ff) [n:127.0.0.1:53979_adp%2Ff ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 2365774 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [n:127.0.0.1:53979_adp%2Ff ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@76c1868d [junit4] 2> 2365782 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [n:127.0.0.1:53979_adp%2Ff ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@76c1868d [junit4] 2> 2365782 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [n:127.0.0.1:53979_adp%2Ff ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@76c1868d [junit4] 2> 2365784 INFO (TEST-TriLevelCompositeIdRoutingTest.test-seed#[66ECA2EF096B57D7]) [n:127.0.0.1:53979_adp%2Ff ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\..\..\..\..\..\..\..\..\..\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\shard-2-001\cores [junit4] 2> 2365820 INFO (qtp1938830154-24447) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params node=127.0.0.1:53979_adp%252Ff&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 2365822 INFO (OverseerThreadFactory-9311-thread-4-processing-n:127.0.0.1:53945_adp%2Ff) [n:127.0.0.1:53945_adp%2Ff ] o.a.s.c.a.c.AddReplicaCmd Node Identified 127.0.0.1:53979_adp%2Ff for creating new replica [junit4] 2> 2365825 INFO (qtp1347767103-24525) [n:127.0.0.1:53979_adp%2Ff ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_n43&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT [junit4] 2> 2365827 INFO (qtp1347767103-24525) [n:127.0.0.1:53979_adp%2Ff ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 2366865 INFO (qtp1347767103-24525) [n:127.0.0.1:53979_adp%2Ff c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 2366887 INFO (qtp1347767103-24525) [n:127.0.0.1:53979_adp%2Ff c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.s.IndexSchema [collection1_shard1_replica_n43] Schema name=test [junit4] 2> 2366991 INFO (qtp1347767103-24525) [n:127.0.0.1:53979_adp%2Ff c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id [junit4] 2> 2367009 INFO (qtp1347767103-24525) [n:127.0.0.1:53979_adp%2Ff c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard1_replica_n43' using configuration from collection collection1, trusted=true [junit4] 2> 2367010 INFO (qtp1347767103-24525) [n:127.0.0.1:53979_adp%2Ff c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1.shard1.replica_n43' (registry 'solr.core.collection1.shard1.replica_n43') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@76c1868d [junit4] 2> 2367010 INFO (qtp1347767103-24525) [n:127.0.0.1:53979_adp%2Ff c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 2367010 INFO (qtp1347767103-24525) [n:127.0.0.1:53979_adp%2Ff c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.c.SolrCore [[collection1_shard1_replica_n43] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\shard-2-001\cores\collection1_shard1_replica_n43], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\..\..\..\..\..\..\..\..\..\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TriLevelCompositeIdRoutingTest_66ECA2EF096B57D7-001\shard-2-001\cores\collection1_shard1_replica_n43\data\] [junit4] 2> 2367020 INFO (qtp1347767103-24525) [n:127.0.0.1:53979_adp%2Ff c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=22, maxMergeAtOnceExplicit=35, maxMergedSegmentMB=40.830078125, floorSegmentMB=0.8603515625, forceMergeDeletesPctAllowed=27.020388044893384, segmentsPerTier=27.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0 [junit4] 2> 2367067 WARN (qtp1347767103-24525) [n:127.0.0.1:53979_adp%2Ff c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}} [junit4] 2> 2367258 INFO (qtp1347767103-24525) [n:127.0.0.1:53979_adp%2Ff c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2367259 INFO (qtp1347767103-24525) [n:127.0.0.1:53979_adp%2Ff c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 2367261 INFO (qtp1347767103-24525) [n:127.0.0.1:53979_adp%2Ff c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2367261 INFO (qtp1347767103-24525) [n:127.0.0.1:53979_adp%2Ff c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2367263 INFO (qtp1347767103-24525) [n:127.0.0.1:53979_adp%2Ff c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=20, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 2367264 INFO (qtp1347767103-24525) [n:127.0.0.1:53979_adp%2Ff c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.s.SolrIndexSearcher Opening [Searcher@403bf44b[collection1_shard1_replica_n43] main] [junit4] 2> 2367266 INFO (qtp1347767103-24525) [n:127.0.0.1:53979_adp%2Ff c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 2367268 INFO (qtp1347767103-24525) [n:127.0.0.1:53979_adp%2Ff c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 2367269 INFO (qtp1347767103-24525) [n:127.0.0.1:53979_adp%2Ff c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 2367269 INFO (qtp1347767103-24525) [n:127.0.0.1:53979_adp%2Ff c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1594225705527279616 [junit4] 2> 2367270 INFO (searcherExecutor-9336-thread-1-processing-n:127.0.0.1:53979_adp%2Ff x:collection1_shard1_replica_n43 s:shard1 c:collection1) [n:127.0.0.1:53979_adp%2Ff c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.c.SolrCore [collection1_shard1_replica_n43] Registered new searcher Searcher@403bf44b[collection1_shard1_replica_n43] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2367273 INFO (qtp1347767103-24525) [n:127.0.0.1:53979_adp%2Ff c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.c.ZkShardTerms Successful update terms at /collections/collection1/terms/shard1 to Terms{values={core_node44=0}, version=0} [junit4] 2> 2367277 INFO (qtp1347767103-24525) [n:127.0.0.1:53979_adp%2Ff c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.c.ShardLeaderElectionContext Enough replicas found to [...truncated too long message...] TestNumericRangeQuery32, TestReplicaProperties, DisMaxRequestHandlerTest, TestClassicSimilarityFactory, CollectionPropsTest, TestSkipOverseerOperations, ClusterStateTest, TestRebalanceLeaders, TestDeleteCollectionOnDownNodes, TestSerializedLuceneMatchVersion, ZkFailoverTest, DOMUtilTest, TestLegacyFieldCache, SimpleFacetsTest, RemoteQueryErrorTest, CurrencyFieldTypeTest, TestRawTransformer, TestFieldCacheSort, SchemaApiFailureTest, CollectionsAPIDistributedZkTest, PrimitiveFieldTypeTest, BlobRepositoryCloudTest, TestFieldCollectionResource, CdcrReplicationHandlerTest, OverseerStatusTest, TestAtomicUpdateErrorCases, TestHashPartitioner, TestFreeTextSuggestions, NotRequiredUniqueKeyTest, TestCollectionAPI, TestSolrQueryParser, TestSolrXml, SubstringBytesRefFilterTest, TestCloudDeleteByQuery, TestRandomFaceting, SpellCheckComponentTest, HdfsNNFailoverTest, SystemInfoHandlerTest, TestSQLHandlerNonCloud, TermVectorComponentTest, HdfsSyncSliceTest, DeleteShardTest, TestFuzzyAnalyzedSuggestions, GraphQueryTest, MergeStrategyTest, TestDFRSimilarityFactory, ManagedSchemaRoundRobinCloudTest, MinimalSchemaTest, TestXmlQParser, SimplePostToolTest, TestLMDirichletSimilarityFactory, DistributedSpellCheckComponentTest, CSVRequestHandlerTest, ChaosMonkeySafeLeaderWithPullReplicasTest, TestManagedStopFilterFactory, TestLegacyFieldReuse, TestSortableTextField, TestFieldTypeCollectionResource, DistributedVersionInfoTest, PeerSyncReplicationTest, BJQParserTest, TestUtilizeNode, ConfigSetsAPITest, OverseerModifyCollectionTest, TestCodecSupport, SolrCoreCheckLockOnStartupTest, BlockJoinFacetRandomTest, TestComputePlanAction, TestDocSet, SortByFunctionTest, VersionInfoTest, QueryResultKeyTest, TestReloadAndDeleteDocs, LoggingHandlerTest, ReplaceNodeTest, SparseHLLTest, TestImplicitCoreProperties, BadComponentTest, ClassificationUpdateProcessorFactoryTest, SoftAutoCommitTest, TestPullReplica, CoreSorterTest, IndexSchemaTest, ClassificationUpdateProcessorTest, BasicDistributedZk2Test, TestSolr4Spatial2, AutoScalingHandlerTest, UUIDFieldTest, TestSha256AuthenticationProvider, IndexBasedSpellCheckerTest, DistributedIntervalFacetingTest, TestBlendedInfixSuggestions, CustomHighlightComponentTest, SpellCheckCollatorTest, TestReversedWildcardFilterFactory, TestLRUCache, TestConfigSetsAPI, TestUnifiedSolrHighlighter, TestRandomCollapseQParserPlugin, TestOrdValues, CreateCollectionCleanupTest, ZkControllerTest, TestStressReorder, TestStressVersions, StatsComponentTest, BadIndexSchemaTest, TestSort, TestFunctionQuery, DirectUpdateHandlerTest, TestBadConfig, HighlighterTest, ShowFileRequestHandlerTest, SolrIndexSplitterTest, TestCoreDiscovery, SuggesterFSTTest, TestFoldingMultitermQuery, SuggesterTest, TestCSVLoader, TestUpdate, QueryEqualityTest, DistanceFunctionTest, TestSolrDeletionPolicy1, XsltUpdateRequestHandlerTest, TestQueryUtils, DocumentAnalysisRequestHandlerTest, RequestHandlersTest, TestValueSourceCache, MoreLikeThisHandlerTest, TestCollationField, ReturnFieldsTest, TestCSVResponseWriter, TestPHPSerializedResponseWriter, SearchHandlerTest, TestPhraseSuggestions, TestSweetSpotSimilarityFactory, TestLMJelinekMercerSimilarityFactory, TestBM25SimilarityFactory, TestFastWriter, TestFastOutputStream, TestFastLRUCache, PreAnalyzedFieldTest, TestSystemIdResolver, TestSuggestSpellingConverter, RAMDirectoryFactoryTest, TestUtils, TestDocumentBuilder, ZkNodePropsTest, SliceStateTest, FileUtilsTest, DistributedMLTComponentTest, TestRTGBase, TestCursorMarkWithoutUniqueKey, TestDistributedMissingSort, TestHighlightDedupGrouping, TestSimpleTrackingShardHandler, TestLuceneIndexBackCompat, TestEmbeddedSolrServerAdminHandler, TestJettySolrRunner, AddReplicaTest, AliasIntegrationTest, AsyncCallRequestStatusResponseTest, CloudExitableDirectoryReaderTest, CreateRoutedAliasTest, DeleteInactiveReplicaTest, DeleteReplicaTest, DistribDocExpirationUpdateProcessorTest, ForceLeaderTest, LeaderFailoverAfterPartitionTest, MigrateRouteKeyTest, NodeMutatorTest, OutOfBoxZkACLAndCredentialsProvidersTest, OverseerTaskQueueTest, SolrCloudExampleTest, TestCloudSearcherWarming, TestMiniSolrCloudClusterSSL, TestRequestForwarding, TestSegmentSorting, TestSizeLimitedDistributedMap, TestSolrCloudWithKerberosAlt, TestStressLiveNodes, TestTolerantUpdateProcessorCloud, TestTolerantUpdateProcessorRandomCloud, TriLevelCompositeIdRoutingTest, ZkShardTermsTest, AssignTest, CollectionReloadTest, CollectionTooManyReplicasTest, CollectionsAPIAsyncDistributedZkTest, SimpleCollectionCreateDeleteTest, TestHdfsCloudBackupRestore, TestRequestStatusCollectionAPI, AutoAddReplicasIntegrationTest, AutoAddReplicasPlanActionTest, ComputePlanActionTest, HttpTriggerListenerTest, MetricTriggerTest, SystemLogListenerTest, TestClusterStateProvider, TestNodeLostTrigger, TestSimDistributedQueue, TestTriggerIntegration, CdcrBidirectionalTest, CdcrVersionReplicationTest, HdfsBasicDistributedZkTest, HdfsRecoverLeaseTest, HdfsRecoveryZkTest, HdfsThreadLeakTest, HdfsUnloadDistributedZkTest, StressHdfsTest, TestClusterStateMutator, ZkStateReaderTest, ZkStateWriterTest, RuleEngineTest, RulesTest, TestDirectoryFactory, TestDynamicLoading, TestInfoStreamLogging, TestInitParams, TestSimpleTextCodec, TestSolrConfigHandler, TestSolrCoreSnapshots, TestCoreBackup, TestHdfsBackupRestoreCore, TestReplicationHandlerBackup, TestReqParamsAPI, TestSolrConfigHandlerCloud, MetricsHandlerTest, TestConfigsApi, DistributedDebugComponentTest, DistributedFacetExistsSmallTest, DistributedQueryComponentCustomSortTest] [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=DistributedQueryComponentCustomSortTest -Dtests.seed=66ECA2EF096B57D7 -Dtests.slow=true -Dtests.locale=es-MX -Dtests.timezone=Africa/Lome -Dtests.asserts=true -Dtests.file.encoding=Cp1252 [junit4] ERROR 0.00s J1 | DistributedQueryComponentCustomSortTest (suite) <<< [junit4] > Throwable #1: java.io.IOException: Could not remove the following files (in the order of attempts): [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedQueryComponentCustomSortTest_66ECA2EF096B57D7-001\tempDir-001\shard2\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedQueryComponentCustomSortTest_66ECA2EF096B57D7-001\tempDir-001\shard2\collection1 [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedQueryComponentCustomSortTest_66ECA2EF096B57D7-001\tempDir-001\shard2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedQueryComponentCustomSortTest_66ECA2EF096B57D7-001\tempDir-001\shard2 [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedQueryComponentCustomSortTest_66ECA2EF096B57D7-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedQueryComponentCustomSortTest_66ECA2EF096B57D7-001\tempDir-001 [junit4] > at __randomizedtesting.SeedInfo.seed([66ECA2EF096B57D7]:0) [junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329) [junit4] > at java.lang.Thread.run(Thread.java:748) [junit4] Completed [643/781 (3!)] on J1 in 10.23s, 1 test, 1 error <<< FAILURES! [...truncated 49946 lines...] [repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/7205/consoleText [repro] Revision: 28de8218fee732077d91d52fb04e6abe427efdc7 [repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UseG1GC" [repro] ant clean [...truncated 6 lines...] [repro] Test suites by module: [repro] lucene\replicator [repro] HttpReplicatorTest [repro] lucene\core [repro] TestFileSwitchDirectory [repro] solr\core [repro] TriLevelCompositeIdRoutingTest [repro] DistributedQueryComponentCustomSortTest [repro] TestSolrConfigHandler [repro] ant compile-test [...truncated 959 lines...] [repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.HttpReplicatorTest" -Dtests.showOutput=onerror "-Dargs=-XX:+UseCompressedOops -XX:+UseG1GC" -Dtests.seed=E725F21B37EF101D -Dtests.slow=true -Dtests.locale=de -Dtests.timezone=Europe/Busingen -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [...truncated 74 lines...] [repro] ant compile-test [...truncated 88 lines...] [repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.TestFileSwitchDirectory" -Dtests.showOutput=onerror "-Dargs=-XX:+UseCompressedOops -XX:+UseG1GC" -Dtests.seed=2D3C5A5B0EEAF5F6 -Dtests.slow=true -Dtests.locale=es -Dtests.timezone=America/Araguaina -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [...truncated 289 lines...] [repro] ant compile-test [...truncated 2524 lines...] [repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=15 -Dtests.class="*.TriLevelCompositeIdRoutingTest|*.DistributedQueryComponentCustomSortTest|*.TestSolrConfigHandler" -Dtests.showOutput=onerror "-Dargs=-XX:+UseCompressedOops -XX:+UseG1GC" -Dtests.seed=66ECA2EF096B57D7 -Dtests.slow=true -Dtests.locale=hr -Dtests.timezone=Antarctica/Davis -Dtests.asserts=true -Dtests.file.encoding=Cp1252 [...truncated 126 lines...] [repro] Failures: [repro] 0/5 failed: org.apache.lucene.replicator.http.HttpReplicatorTest [repro] 0/5 failed: org.apache.lucene.store.TestFileSwitchDirectory [repro] 0/5 failed: org.apache.solr.cloud.TriLevelCompositeIdRoutingTest [repro] 0/5 failed: org.apache.solr.core.TestSolrConfigHandler [repro] 0/5 failed: org.apache.solr.handler.component.DistributedQueryComponentCustomSortTest [repro] Exiting with code 0 [...truncated 75 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org