Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Windows/297/
Java: 64bit/jdk1.8.0_144 -XX:+UseCompressedOops -XX:+UseParallelGC
4 tests failed.
FAILED: junit.framework.TestSuite.org.apache.lucene.search.TestShardSearching
Error Message:
Could not remove the following files (in the order of attempts):
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J1\temp\lucene.search.TestShardSearching_A47C82DB4731CD50-001\ShardSearchingTestBase-001:
java.nio.file.AccessDeniedException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J1\temp\lucene.search.TestShardSearching_A47C82DB4731CD50-001\ShardSearchingTestBase-001
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J1\temp\lucene.search.TestShardSearching_A47C82DB4731CD50-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J1\temp\lucene.search.TestShardSearching_A47C82DB4731CD50-001
Stack Trace:
java.io.IOException: Could not remove the following files (in the order of
attempts):
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J1\temp\lucene.search.TestShardSearching_A47C82DB4731CD50-001\ShardSearchingTestBase-001:
java.nio.file.AccessDeniedException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J1\temp\lucene.search.TestShardSearching_A47C82DB4731CD50-001\ShardSearchingTestBase-001
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J1\temp\lucene.search.TestShardSearching_A47C82DB4731CD50-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J1\temp\lucene.search.TestShardSearching_A47C82DB4731CD50-001
at __randomizedtesting.SeedInfo.seed([A47C82DB4731CD50]: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.lucene.spatial.prefix.NumberRangeFacetsTest
Error Message:
Could not remove the following files (in the order of attempts):
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\spatial-extras\test\J1\temp\lucene.spatial.prefix.NumberRangeFacetsTest_156781DD9D38DB52-001\index-MMapDirectory-001:
java.nio.file.AccessDeniedException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\spatial-extras\test\J1\temp\lucene.spatial.prefix.NumberRangeFacetsTest_156781DD9D38DB52-001\index-MMapDirectory-001
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\spatial-extras\test\J1\temp\lucene.spatial.prefix.NumberRangeFacetsTest_156781DD9D38DB52-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\spatial-extras\test\J1\temp\lucene.spatial.prefix.NumberRangeFacetsTest_156781DD9D38DB52-001
Stack Trace:
java.io.IOException: Could not remove the following files (in the order of
attempts):
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\spatial-extras\test\J1\temp\lucene.spatial.prefix.NumberRangeFacetsTest_156781DD9D38DB52-001\index-MMapDirectory-001:
java.nio.file.AccessDeniedException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\spatial-extras\test\J1\temp\lucene.spatial.prefix.NumberRangeFacetsTest_156781DD9D38DB52-001\index-MMapDirectory-001
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\spatial-extras\test\J1\temp\lucene.spatial.prefix.NumberRangeFacetsTest_156781DD9D38DB52-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\spatial-extras\test\J1\temp\lucene.spatial.prefix.NumberRangeFacetsTest_156781DD9D38DB52-001
at __randomizedtesting.SeedInfo.seed([156781DD9D38DB52]: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.dataimport.TestZKPropertiesWriter
Error Message:
Could not remove the following files (in the order of attempts):
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestZKPropertiesWriter_F5950F6308857AC2-001\zkData-001\version-2:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestZKPropertiesWriter_F5950F6308857AC2-001\zkData-001\version-2
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestZKPropertiesWriter_F5950F6308857AC2-001\zkData-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestZKPropertiesWriter_F5950F6308857AC2-001\zkData-001
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestZKPropertiesWriter_F5950F6308857AC2-001\zkData-001\version-2\log.1:
java.nio.file.AccessDeniedException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestZKPropertiesWriter_F5950F6308857AC2-001\zkData-001\version-2\log.1
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestZKPropertiesWriter_F5950F6308857AC2-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestZKPropertiesWriter_F5950F6308857AC2-001
Stack Trace:
java.io.IOException: Could not remove the following files (in the order of
attempts):
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestZKPropertiesWriter_F5950F6308857AC2-001\zkData-001\version-2:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestZKPropertiesWriter_F5950F6308857AC2-001\zkData-001\version-2
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestZKPropertiesWriter_F5950F6308857AC2-001\zkData-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestZKPropertiesWriter_F5950F6308857AC2-001\zkData-001
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestZKPropertiesWriter_F5950F6308857AC2-001\zkData-001\version-2\log.1:
java.nio.file.AccessDeniedException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestZKPropertiesWriter_F5950F6308857AC2-001\zkData-001\version-2\log.1
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestZKPropertiesWriter_F5950F6308857AC2-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestZKPropertiesWriter_F5950F6308857AC2-001
at __randomizedtesting.SeedInfo.seed([F5950F6308857AC2]: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.cloud.TestDistribDocBasedVersion
Error Message:
Could not remove the following files (in the order of attempts):
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\control-001\analysisconfs:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\control-001\analysisconfs
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\control-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\control-001
Stack Trace:
java.io.IOException: Could not remove the following files (in the order of
attempts):
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\control-001\analysisconfs:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\control-001\analysisconfs
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\control-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\control-001
at __randomizedtesting.SeedInfo.seed([37102F90235AD330]: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 972 lines...]
[junit4] Suite: org.apache.lucene.search.TestShardSearching
[junit4] 2> NOTE: test params are:
codec=FastCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST,
chunkSize=7, maxDocsPerChunk=601, blockSize=9),
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST,
chunkSize=7, blockSize=9)), sim=RandomSimilarity(queryNorm=true): {},
locale=ar-EG, timezone=CNT
[junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 1.8.0_144
(64-bit)/cpus=3,threads=1,free=172345616,total=235405312
[junit4] 2> NOTE: All tests run in this JVM: [TestMmapDirectory,
TestTransactionRollback, TestTryDelete, TestIntsRef, TestFileSwitchDirectory,
TestDeterminism, TestInfoStream, TestIntArrayDocIdSet,
TestNRTReaderWithThreads, TestPackedInts, TestDisjunctionMaxQuery,
Test2BPostings, TestIndexedDISI, TestConcurrentMergeScheduler, TestManyFields,
TestStressIndexing2, TestPayloads, TestMathUtil, TestBooleanSimilarity,
TestCompiledAutomaton, TestIndexWriterReader, TestSortRandom, TestTimSorter,
Test2BPagedBytes, TestMutableValues, TestPerFieldPostingsFormat2,
TestFixedBitDocIdSet, TestSimpleExplanations, TestNGramPhraseQuery,
TestVersion, TestFilterWeight, TestFieldMaskingSpanQuery, TestRollback,
TestTotalHitCountCollector, TestCachingTokenFilter, TestIsCurrent,
TestRollingBuffer, TestDirectoryReaderReopen, TestSpansEnum,
TestIndexWriterDelete, TestFilterSpans, TestNormsFieldExistsQuery,
TestDelegatingAnalyzerWrapper, TestIndexWriterConfig, TestDoubleValuesSource,
TestCharTermAttributeImpl, TestFrequencyTrackingRingBuffer, TestIndexCommit,
TestSwappedIndexFiles, TestNot, TestIndexOrDocValuesQuery, TestSegmentTermDocs,
Test2BNumericDocValues, TestCharsRef, TestDocValues, TestLongRangeFieldQueries,
TestIndexWriterOnDiskFull, TestNearSpansOrdered, TestSearchAfter,
Test2BSortedDocValuesFixedSorted, TestTermQuery, TestNRTReaderCleanup,
TestCharArraySet, TestMultiDocValues, TestMultiCollector, TestParallelTermEnum,
TestSentinelIntSet, TestSingleInstanceLockFactory, TestPrefixCodedTerms,
TestAutomatonQueryUnicode, TestStressIndexing, TestLongBitSet,
TestPerSegmentDeletes, TestMergeSchedulerExternal, TestDeletionPolicy,
TestTransactions, TestIndexWriterLockRelease, TestDocumentWriter,
TestMatchNoDocsQuery, TestIntRangeFieldQueries, TestSloppyPhraseQuery2,
TestBasics, TestMergePolicyWrapper, TestSpanMultiTermQueryWrapper,
TestSimpleFSDirectory, TestFuzzyQuery, Test2BBinaryDocValues, TestFixedBitSet,
TestDocValuesRewriteMethod, TestBytesStore, TestNoDeletionPolicy,
TestBoostQuery, TestPerFieldDocValuesFormat, TestFieldType,
TestPrefixInBooleanQuery, Test2BPostingsBytes, TestMultiLevelSkipList,
TestTermsEnum, TestDocValuesScoring, TestSPIClassIterator, TestTermdocPerf,
TestElevationComparator, TestLucene50StoredFieldsFormatHighCompression,
TestTermRangeQuery, TestPolygon2D, TestIndexWriterThreadsToSegments,
TestCharsRefBuilder, TestIndexWriterNRTIsCurrent, TestWildcard,
TestCachingCollector, TestRadixSelector, TestPointValues,
TestNativeFSLockFactory, TestIndexWriterCommit, TestFSTs, TestGraphTokenizers,
TestAddIndexes, TestShardSearching]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestShardSearching
-Dtests.seed=A47C82DB4731CD50 -Dtests.slow=true -Dtests.locale=ar-EG
-Dtests.timezone=CNT -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.00s J1 | TestShardSearching (suite) <<<
[junit4] > Throwable #1: java.io.IOException: Could not remove the
following files (in the order of attempts):
[junit4] >
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J1\temp\lucene.search.TestShardSearching_A47C82DB4731CD50-001\ShardSearchingTestBase-001:
java.nio.file.AccessDeniedException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J1\temp\lucene.search.TestShardSearching_A47C82DB4731CD50-001\ShardSearchingTestBase-001
[junit4] >
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J1\temp\lucene.search.TestShardSearching_A47C82DB4731CD50-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J1\temp\lucene.search.TestShardSearching_A47C82DB4731CD50-001
[junit4] > at
__randomizedtesting.SeedInfo.seed([A47C82DB4731CD50]:0)
[junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] Completed [230/455 (1!)] on J1 in 4.57s, 1 test, 1 error <<<
FAILURES!
[...truncated 8381 lines...]
[junit4] Suite: org.apache.lucene.spatial.prefix.NumberRangeFacetsTest
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70):
{dateRange=PostingsFormat(name=LuceneFixedGap),
id=PostingsFormat(name=Asserting)}, docValues:{}, maxPointsInLeafNode=351,
maxMBSortInHeap=6.289710988825599, sim=RandomSimilarity(queryNorm=true): {},
locale=en-IE, timezone=Pacific/Guadalcanal
[junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 1.8.0_144
(64-bit)/cpus=3,threads=1,free=33440640,total=133693440
[junit4] 2> NOTE: All tests run in this JVM: [TestBBoxStrategy,
SpatialPrefixTreeTest, TestTermQueryPrefixGridStrategy,
TestPointVectorStrategy, DateNRStrategyTest,
RandomSpatialOpFuzzyPrefixTreeTest, NumberRangeFacetsTest]
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=NumberRangeFacetsTest -Dtests.seed=156781DD9D38DB52
-Dtests.slow=true -Dtests.locale=en-IE -Dtests.timezone=Pacific/Guadalcanal
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J1 | NumberRangeFacetsTest (suite) <<<
[junit4] > Throwable #1: java.io.IOException: Could not remove the
following files (in the order of attempts):
[junit4] >
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\spatial-extras\test\J1\temp\lucene.spatial.prefix.NumberRangeFacetsTest_156781DD9D38DB52-001\index-MMapDirectory-001:
java.nio.file.AccessDeniedException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\spatial-extras\test\J1\temp\lucene.spatial.prefix.NumberRangeFacetsTest_156781DD9D38DB52-001\index-MMapDirectory-001
[junit4] >
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\spatial-extras\test\J1\temp\lucene.spatial.prefix.NumberRangeFacetsTest_156781DD9D38DB52-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\spatial-extras\test\J1\temp\lucene.spatial.prefix.NumberRangeFacetsTest_156781DD9D38DB52-001
[junit4] > at
__randomizedtesting.SeedInfo.seed([156781DD9D38DB52]:0)
[junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] Completed [20/23 (1!)] on J1 in 1.59s, 20 tests, 1 error <<<
FAILURES!
[...truncated 3942 lines...]
[junit4] Suite: org.apache.solr.cloud.TestDistribDocBasedVersion
[junit4] 2> Creating dataDir:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\init-core-data-001
[junit4] 2> 2818934 INFO
(SUITE-TestDistribDocBasedVersion-seed#[37102F90235AD330]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 2818944 INFO
(SUITE-TestDistribDocBasedVersion-seed#[37102F90235AD330]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 2818944 INFO
(SUITE-TestDistribDocBasedVersion-seed#[37102F90235AD330]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 2818944 INFO
(SUITE-TestDistribDocBasedVersion-seed#[37102F90235AD330]-worker) [ ]
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property:
/wcax/kr
[junit4] 2> 2819008 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2819009 INFO (Thread-5978) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2819009 INFO (Thread-5978) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 2819015 ERROR (Thread-5978) [ ] 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> 2819109 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.ZkTestServer start zk server on port:56510
[junit4] 2> 2819148 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig-externalversionconstraint.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 2819157 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf\schema15.xml
to /configs/conf1/schema.xml
[junit4] 2> 2819160 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 2819163 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf\stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 2819168 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf\protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 2819169 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf\currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 2819172 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf\enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 2819182 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf\open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 2819185 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf\mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 2819188 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf\old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 2819191 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf\synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 2819194 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase Will use NRT replicas unless explicitly
asked otherwise
[junit4] 2> 2820639 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 2820640 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@84082c9{/wcax/kr,null,AVAILABLE}
[junit4] 2> 2820641 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@120d49a6{HTTP/1.1,[http/1.1]}{127.0.0.1:56517}
[junit4] 2> 2820641 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.e.j.s.Server Started @2828858ms
[junit4] 2> 2820641 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\tempDir-001/control/data,
replicaType=NRT, hostContext=/wcax/kr, hostPort=56517,
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\..\..\..\..\..\..\..\..\..\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\control-001\cores}
[junit4] 2> 2820642 ERROR
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2820642 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.2.0
[junit4] 2> 2820642 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2820642 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2820642 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-11-09T09:54:09.045Z
[junit4] 2> 2820659 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15fa03373ba0002, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 2820660 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 2820661 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\control-001\solr.xml
[junit4] 2> 2820674 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay
is ignored
[junit4] 2> 2820674 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter
autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 2820675 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@1ab42e41, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 2820688 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56510/solr
[junit4] 2> 2820697 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15fa03373ba0003, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 2821058 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56517_wcax%2Fkr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2821060 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56517_wcax%2Fkr ] o.a.s.c.OverseerElectionContext I am going to
be the leader 127.0.0.1:56517_wcax%2Fkr
[junit4] 2> 2821062 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56517_wcax%2Fkr ] o.a.s.c.Overseer Overseer
(id=98973859670786052-127.0.0.1:56517_wcax%2Fkr-n_0000000000) starting
[junit4] 2> 2821075 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56517_wcax%2Fkr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:56517_wcax%2Fkr
[junit4] 2> 2821077 INFO
(OverseerStateUpdate-98973859670786052-127.0.0.1:56517_wcax%2Fkr-n_0000000000)
[n:127.0.0.1:56517_wcax%2Fkr ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (0) -> (1)
[junit4] 2> 2821254 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56517_wcax%2Fkr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1ab42e41
[junit4] 2> 2821265 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56517_wcax%2Fkr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1ab42e41
[junit4] 2> 2821265 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56517_wcax%2Fkr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1ab42e41
[junit4] 2> 2821268 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56517_wcax%2Fkr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\..\..\..\..\..\..\..\..\..\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\control-001\cores
[junit4] 2> 2821312 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2821314 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:56510/solr ready
[junit4] 2> 2821315 INFO (qtp476055614-30761)
[n:127.0.0.1:56517_wcax%2Fkr ] 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:56517_wcax%252Fkr&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2821317 INFO
(OverseerThreadFactory-11706-thread-1-processing-n:127.0.0.1:56517_wcax%2Fkr)
[n:127.0.0.1:56517_wcax%2Fkr ] o.a.s.c.CreateCollectionCmd Create collection
control_collection
[junit4] 2> 2821439 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr ] 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> 2821440 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr ] o.a.s.c.TransientSolrCoreCacheDefault
Allocating transient cache for 4 transient cores
[junit4] 2> 2821550 INFO
(zkCallback-5384-thread-1-processing-n:127.0.0.1:56517_wcax%2Fkr)
[n:127.0.0.1:56517_wcax%2Fkr ] 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> 2822540 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr c:control_collection s:shard1
x:control_collection_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 7.2.0
[junit4] 2> 2822562 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr 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> 2822663 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr 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> 2822694 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr 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> 2822695 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr 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@1ab42e41
[junit4] 2> 2822695 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr c:control_collection s:shard1
x:control_collection_shard1_replica_n1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 2822696 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr 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-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\control-001\cores\control_collection_shard1_replica_n1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\..\..\..\..\..\..\..\..\..\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\control-001\cores\control_collection_shard1_replica_n1\data\]
[junit4] 2> 2822707 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr c:control_collection s:shard1
x:control_collection_shard1_replica_n1] o.a.s.u.RandomMergePolicy
RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy:
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=921266246,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 2822968 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr 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> 2822968 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr 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> 2822968 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr c:control_collection s:shard1
x:control_collection_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit:
disabled
[junit4] 2> 2822968 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr c:control_collection s:shard1
x:control_collection_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit:
disabled
[junit4] 2> 2822977 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr c:control_collection s:shard1
x:control_collection_shard1_replica_n1] o.a.s.u.RandomMergePolicy
RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy:
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1381861630,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 2822978 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr c:control_collection s:shard1
x:control_collection_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@37ccc8e1[control_collection_shard1_replica_n1] main]
[junit4] 2> 2822981 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr c:control_collection s:shard1
x:control_collection_shard1_replica_n1] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 2822992 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr 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> 2822992 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr c:control_collection s:shard1
x:control_collection_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will
be reserved for 10000ms.
[junit4] 2> 2822992 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr 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 1583581758902763520
[junit4] 2> 2822992 INFO
(searcherExecutor-11709-thread-1-processing-n:127.0.0.1:56517_wcax%2Fkr
x:control_collection_shard1_replica_n1 s:shard1 c:control_collection)
[n:127.0.0.1:56517_wcax%2Fkr 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@37ccc8e1[control_collection_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2823022 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr c:control_collection s:shard1
x:control_collection_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext
Enough replicas found to continue.
[junit4] 2> 2823022 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr 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> 2823022 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr c:control_collection s:shard1
x:control_collection_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:56517/wcax/kr/control_collection_shard1_replica_n1/
[junit4] 2> 2823022 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr 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> 2823022 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr c:control_collection s:shard1
x:control_collection_shard1_replica_n1] o.a.s.c.SyncStrategy
http://127.0.0.1:56517/wcax/kr/control_collection_shard1_replica_n1/ has no
replicas
[junit4] 2> 2823022 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr 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> 2823031 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr 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:56517/wcax/kr/control_collection_shard1_replica_n1/ shard1
[junit4] 2> 2823132 INFO
(zkCallback-5384-thread-2-processing-n:127.0.0.1:56517_wcax%2Fkr)
[n:127.0.0.1:56517_wcax%2Fkr ] 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> 2823137 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr 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> 2823149 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr 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=1710
[junit4] 2> 2823155 INFO (qtp476055614-30761)
[n:127.0.0.1:56517_wcax%2Fkr ] o.a.s.h.a.CollectionsHandler Wait for new
collection to be active for at most 30 seconds. Check all shard replicas
[junit4] 2> 2823247 INFO
(zkCallback-5384-thread-2-processing-n:127.0.0.1:56517_wcax%2Fkr)
[n:127.0.0.1:56517_wcax%2Fkr ] 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> 2823319 INFO
(OverseerCollectionConfigSetProcessor-98973859670786052-127.0.0.1:56517_wcax%2Fkr-n_0000000000)
[n:127.0.0.1:56517_wcax%2Fkr ] 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> 2824168 INFO (qtp476055614-30761)
[n:127.0.0.1:56517_wcax%2Fkr ] 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:56517_wcax%252Fkr&wt=javabin&version=2}
status=0 QTime=2852
[junit4] 2> 2824169 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15fa03373ba0005, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 2824191 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2824196 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:56510/solr ready
[junit4] 2> 2824196 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection
loss:false
[junit4] 2> 2824198 INFO (qtp476055614-30766)
[n:127.0.0.1:56517_wcax%2Fkr ] 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> 2824202 INFO
(OverseerThreadFactory-11706-thread-2-processing-n:127.0.0.1:56517_wcax%2Fkr)
[n:127.0.0.1:56517_wcax%2Fkr ] o.a.s.c.CreateCollectionCmd Create collection
collection1
[junit4] 2> 2824203 WARN
(OverseerThreadFactory-11706-thread-2-processing-n:127.0.0.1:56517_wcax%2Fkr)
[n:127.0.0.1:56517_wcax%2Fkr ] o.a.s.c.CreateCollectionCmd It is unusual to
create a collection (collection1) without cores.
[junit4] 2> 2824413 INFO (qtp476055614-30766)
[n:127.0.0.1:56517_wcax%2Fkr ] o.a.s.h.a.CollectionsHandler Wait for new
collection to be active for at most 30 seconds. Check all shard replicas
[junit4] 2> 2824415 INFO (qtp476055614-30766)
[n:127.0.0.1:56517_wcax%2Fkr ] 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=216
[junit4] 2> 2825124 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\shard-1-001
of type NRT
[junit4] 2> 2825124 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 2825125 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@6cf879c9{/wcax/kr,null,AVAILABLE}
[junit4] 2> 2825125 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@4ce15773{HTTP/1.1,[http/1.1]}{127.0.0.1:56539}
[junit4] 2> 2825125 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.e.j.s.Server Started @2833342ms
[junit4] 2> 2825126 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\tempDir-001/jetty1,
solrconfig=solrconfig.xml, hostContext=/wcax/kr, hostPort=56539,
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\..\..\..\..\..\..\..\..\..\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\shard-1-001\cores}
[junit4] 2> 2825126 ERROR
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2825126 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.2.0
[junit4] 2> 2825126 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2825126 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2825126 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-11-09T09:54:13.529Z
[junit4] 2> 2825130 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 2825130 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\shard-1-001\solr.xml
[junit4] 2> 2825137 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay
is ignored
[junit4] 2> 2825138 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter
autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 2825138 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@1ab42e41, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 2825142 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56510/solr
[junit4] 2> 2825156 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56539_wcax%2Fkr ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (0) -> (1)
[junit4] 2> 2825159 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56539_wcax%2Fkr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2825164 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56539_wcax%2Fkr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:56539_wcax%2Fkr
[junit4] 2> 2825166 INFO (zkCallback-5392-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2825166 INFO
(zkCallback-5384-thread-2-processing-n:127.0.0.1:56517_wcax%2Fkr)
[n:127.0.0.1:56517_wcax%2Fkr ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (1) -> (2)
[junit4] 2> 2825166 INFO
(zkCallback-5397-thread-1-processing-n:127.0.0.1:56539_wcax%2Fkr)
[n:127.0.0.1:56539_wcax%2Fkr ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (1) -> (2)
[junit4] 2> 2825320 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56539_wcax%2Fkr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1ab42e41
[junit4] 2> 2825339 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56539_wcax%2Fkr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1ab42e41
[junit4] 2> 2825340 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56539_wcax%2Fkr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1ab42e41
[junit4] 2> 2825343 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56539_wcax%2Fkr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\..\..\..\..\..\..\..\..\..\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\shard-1-001\cores
[junit4] 2> 2825422 INFO (qtp476055614-30759)
[n:127.0.0.1:56517_wcax%2Fkr ] o.a.s.h.a.CollectionsHandler Invoked
Collection Action :addreplica with params
node=127.0.0.1:56539_wcax%252Fkr&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2825432 INFO
(OverseerCollectionConfigSetProcessor-98973859670786052-127.0.0.1:56517_wcax%2Fkr-n_0000000000)
[n:127.0.0.1:56517_wcax%2Fkr ] 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> 2825432 INFO
(OverseerThreadFactory-11706-thread-3-processing-n:127.0.0.1:56517_wcax%2Fkr)
[n:127.0.0.1:56517_wcax%2Fkr ] o.a.s.c.AddReplicaCmd Node Identified
127.0.0.1:56539_wcax%2Fkr for creating new replica
[junit4] 2> 2825436 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr ] 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> 2825436 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr ] o.a.s.c.TransientSolrCoreCacheDefault
Allocating transient cache for 4 transient cores
[junit4] 2> 2826484 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n41] o.a.s.c.SolrConfig Using Lucene MatchVersion:
7.2.0
[junit4] 2> 2826496 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n41] o.a.s.s.IndexSchema
[collection1_shard2_replica_n41] Schema name=test
[junit4] 2> 2826590 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr 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> 2826610 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr 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> 2826610 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr 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@1ab42e41
[junit4] 2> 2826610 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n41] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 2826611 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr 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-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\shard-1-001\cores\collection1_shard2_replica_n41],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\..\..\..\..\..\..\..\..\..\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\shard-1-001\cores\collection1_shard2_replica_n41\data\]
[junit4] 2> 2826622 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n41] o.a.s.u.RandomMergePolicy RandomMergePolicy
wrapping class org.apache.lucene.index.AlcoholicMergePolicy:
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=921266246,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 2826721 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n41] o.a.s.u.UpdateHandler Using UpdateLog
implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 2826721 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr 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> 2826725 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n41] o.a.s.u.CommitTracker Hard AutoCommit:
disabled
[junit4] 2> 2826725 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n41] o.a.s.u.CommitTracker Soft AutoCommit:
disabled
[junit4] 2> 2826726 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n41] o.a.s.u.RandomMergePolicy RandomMergePolicy
wrapping class org.apache.lucene.index.AlcoholicMergePolicy:
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1381861630,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 2826726 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n41] o.a.s.s.SolrIndexSearcher Opening
[Searcher@5457f55d[collection1_shard2_replica_n41] main]
[junit4] 2> 2826728 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n41] o.a.s.r.ManagedResourceStorage Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 2826729 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr 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> 2826729 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n41] o.a.s.h.ReplicationHandler Commits will be
reserved for 10000ms.
[junit4] 2> 2826730 INFO
(searcherExecutor-11720-thread-1-processing-n:127.0.0.1:56539_wcax%2Fkr
x:collection1_shard2_replica_n41 s:shard2 c:collection1)
[n:127.0.0.1:56539_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n41] o.a.s.c.SolrCore
[collection1_shard2_replica_n41] Registered new searcher
Searcher@5457f55d[collection1_shard2_replica_n41]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2826730 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr 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 1583581762822340608
[junit4] 2> 2826736 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n41] o.a.s.c.ShardLeaderElectionContext Enough
replicas found to continue.
[junit4] 2> 2826736 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr 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> 2826736 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n41] o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:56539/wcax/kr/collection1_shard2_replica_n41/
[junit4] 2> 2826736 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n41] o.a.s.c.SyncStrategy Sync Success - now sync
replicas to me
[junit4] 2> 2826736 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n41] o.a.s.c.SyncStrategy
http://127.0.0.1:56539/wcax/kr/collection1_shard2_replica_n41/ has no replicas
[junit4] 2> 2826736 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n41] o.a.s.c.ShardLeaderElectionContext Found all
replicas participating in election, clear LIR
[junit4] 2> 2826740 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n41] o.a.s.c.ShardLeaderElectionContext I am the
new leader: http://127.0.0.1:56539/wcax/kr/collection1_shard2_replica_n41/
shard2
[junit4] 2> 2826892 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n41] o.a.s.c.ZkController I am the leader, no
recovery necessary
[junit4] 2> 2826897 INFO (qtp1203426378-30808)
[n:127.0.0.1:56539_wcax%2Fkr 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=1460
[junit4] 2> 2826900 INFO (qtp476055614-30759)
[n:127.0.0.1:56517_wcax%2Fkr ] o.a.s.s.HttpSolrCall [admin] webapp=null
path=/admin/collections
params={node=127.0.0.1:56539_wcax%252Fkr&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2}
status=0 QTime=1477
[junit4] 2> 2827433 INFO
(OverseerCollectionConfigSetProcessor-98973859670786052-127.0.0.1:56517_wcax%2Fkr-n_0000000000)
[n:127.0.0.1:56517_wcax%2Fkr ] 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> 2827672 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\shard-2-001
of type NRT
[junit4] 2> 2827672 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 2827673 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@7f1435a9{/wcax/kr,null,AVAILABLE}
[junit4] 2> 2827674 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@46ad5471{HTTP/1.1,[http/1.1]}{127.0.0.1:56552}
[junit4] 2> 2827674 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.e.j.s.Server Started @2835891ms
[junit4] 2> 2827674 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\tempDir-001/jetty2,
solrconfig=solrconfig.xml, hostContext=/wcax/kr, hostPort=56552,
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\shard-2-001\cores}
[junit4] 2> 2827674 ERROR
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2827674 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.2.0
[junit4] 2> 2827674 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2827674 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2827675 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-11-09T09:54:16.078Z
[junit4] 2> 2827679 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 2827680 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\shard-2-001\solr.xml
[junit4] 2> 2827689 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay
is ignored
[junit4] 2> 2827689 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter
autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 2827690 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@1ab42e41, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 2827696 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56510/solr
[junit4] 2> 2827711 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56552_wcax%2Fkr ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (0) -> (2)
[junit4] 2> 2827714 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56552_wcax%2Fkr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2827716 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56552_wcax%2Fkr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:56552_wcax%2Fkr
[junit4] 2> 2827717 INFO
(zkCallback-5384-thread-2-processing-n:127.0.0.1:56517_wcax%2Fkr)
[n:127.0.0.1:56517_wcax%2Fkr ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (2) -> (3)
[junit4] 2> 2827717 INFO (zkCallback-5392-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2827717 INFO
(zkCallback-5403-thread-1-processing-n:127.0.0.1:56552_wcax%2Fkr)
[n:127.0.0.1:56552_wcax%2Fkr ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (2) -> (3)
[junit4] 2> 2827717 INFO
(zkCallback-5397-thread-1-processing-n:127.0.0.1:56539_wcax%2Fkr)
[n:127.0.0.1:56539_wcax%2Fkr ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (2) -> (3)
[junit4] 2> 2827803 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56552_wcax%2Fkr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1ab42e41
[junit4] 2> 2827809 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56552_wcax%2Fkr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1ab42e41
[junit4] 2> 2827810 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56552_wcax%2Fkr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1ab42e41
[junit4] 2> 2827811 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56552_wcax%2Fkr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\shard-2-001\cores
[junit4] 2> 2827852 INFO (qtp476055614-30762)
[n:127.0.0.1:56517_wcax%2Fkr ] o.a.s.h.a.CollectionsHandler Invoked
Collection Action :addreplica with params
node=127.0.0.1:56552_wcax%252Fkr&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2827854 INFO
(OverseerThreadFactory-11706-thread-4-processing-n:127.0.0.1:56517_wcax%2Fkr)
[n:127.0.0.1:56517_wcax%2Fkr ] o.a.s.c.AddReplicaCmd Node Identified
127.0.0.1:56552_wcax%2Fkr for creating new replica
[junit4] 2> 2827857 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr ] 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> 2827857 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr ] o.a.s.c.TransientSolrCoreCacheDefault
Allocating transient cache for 4 transient cores
[junit4] 2> 2828886 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr c:collection1 s:shard1
x:collection1_shard1_replica_n43] o.a.s.c.SolrConfig Using Lucene MatchVersion:
7.2.0
[junit4] 2> 2828895 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr c:collection1 s:shard1
x:collection1_shard1_replica_n43] o.a.s.s.IndexSchema
[collection1_shard1_replica_n43] Schema name=test
[junit4] 2> 2828964 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr 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> 2829005 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr 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> 2829006 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr 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@1ab42e41
[junit4] 2> 2829006 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr c:collection1 s:shard1
x:collection1_shard1_replica_n43] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 2829006 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr 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-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\shard-2-001\cores\collection1_shard1_replica_n43],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\shard-2-001\cores\collection1_shard1_replica_n43\data\]
[junit4] 2> 2829012 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr c:collection1 s:shard1
x:collection1_shard1_replica_n43] o.a.s.u.RandomMergePolicy RandomMergePolicy
wrapping class org.apache.lucene.index.AlcoholicMergePolicy:
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=921266246,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 2829108 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr c:collection1 s:shard1
x:collection1_shard1_replica_n43] o.a.s.u.UpdateHandler Using UpdateLog
implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 2829108 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr 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> 2829110 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr c:collection1 s:shard1
x:collection1_shard1_replica_n43] o.a.s.u.CommitTracker Hard AutoCommit:
disabled
[junit4] 2> 2829110 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr c:collection1 s:shard1
x:collection1_shard1_replica_n43] o.a.s.u.CommitTracker Soft AutoCommit:
disabled
[junit4] 2> 2829111 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr c:collection1 s:shard1
x:collection1_shard1_replica_n43] o.a.s.u.RandomMergePolicy RandomMergePolicy
wrapping class org.apache.lucene.index.AlcoholicMergePolicy:
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1381861630,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 2829112 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr c:collection1 s:shard1
x:collection1_shard1_replica_n43] o.a.s.s.SolrIndexSearcher Opening
[Searcher@53a5ae8f[collection1_shard1_replica_n43] main]
[junit4] 2> 2829113 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr c:collection1 s:shard1
x:collection1_shard1_replica_n43] o.a.s.r.ManagedResourceStorage Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 2829114 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr 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> 2829114 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr c:collection1 s:shard1
x:collection1_shard1_replica_n43] o.a.s.h.ReplicationHandler Commits will be
reserved for 10000ms.
[junit4] 2> 2829115 INFO
(searcherExecutor-11731-thread-1-processing-n:127.0.0.1:56552_wcax%2Fkr
x:collection1_shard1_replica_n43 s:shard1 c:collection1)
[n:127.0.0.1:56552_wcax%2Fkr c:collection1 s:shard1
x:collection1_shard1_replica_n43] o.a.s.c.SolrCore
[collection1_shard1_replica_n43] Registered new searcher
Searcher@53a5ae8f[collection1_shard1_replica_n43]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2829115 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr 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 1583581765323194368
[junit4] 2> 2829120 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr c:collection1 s:shard1
x:collection1_shard1_replica_n43] o.a.s.c.ShardLeaderElectionContext Enough
replicas found to continue.
[junit4] 2> 2829120 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr c:collection1 s:shard1
x:collection1_shard1_replica_n43] o.a.s.c.ShardLeaderElectionContext I may be
the new leader - try and sync
[junit4] 2> 2829120 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr c:collection1 s:shard1
x:collection1_shard1_replica_n43] o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:56552/wcax/kr/collection1_shard1_replica_n43/
[junit4] 2> 2829120 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr c:collection1 s:shard1
x:collection1_shard1_replica_n43] o.a.s.c.SyncStrategy Sync Success - now sync
replicas to me
[junit4] 2> 2829120 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr c:collection1 s:shard1
x:collection1_shard1_replica_n43] o.a.s.c.SyncStrategy
http://127.0.0.1:56552/wcax/kr/collection1_shard1_replica_n43/ has no replicas
[junit4] 2> 2829120 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr c:collection1 s:shard1
x:collection1_shard1_replica_n43] o.a.s.c.ShardLeaderElectionContext Found all
replicas participating in election, clear LIR
[junit4] 2> 2829123 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr c:collection1 s:shard1
x:collection1_shard1_replica_n43] o.a.s.c.ShardLeaderElectionContext I am the
new leader: http://127.0.0.1:56552/wcax/kr/collection1_shard1_replica_n43/
shard1
[junit4] 2> 2829275 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr c:collection1 s:shard1
x:collection1_shard1_replica_n43] o.a.s.c.ZkController I am the leader, no
recovery necessary
[junit4] 2> 2829277 INFO (qtp1850585843-30839)
[n:127.0.0.1:56552_wcax%2Fkr c:collection1 s:shard1
x:collection1_shard1_replica_n43] o.a.s.s.HttpSolrCall [admin] webapp=null
path=/admin/cores
params={qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_n43&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1420
[junit4] 2> 2829279 INFO (qtp476055614-30762)
[n:127.0.0.1:56517_wcax%2Fkr ] o.a.s.s.HttpSolrCall [admin] webapp=null
path=/admin/collections
params={node=127.0.0.1:56552_wcax%252Fkr&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2}
status=0 QTime=1426
[junit4] 2> 2829681 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 3 in directory
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\shard-3-001
of type NRT
[junit4] 2> 2829681 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 2829682 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@68781707{/wcax/kr,null,AVAILABLE}
[junit4] 2> 2829683 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@47901d23{HTTP/1.1,[http/1.1]}{127.0.0.1:56565}
[junit4] 2> 2829683 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.e.j.s.Server Started @2837899ms
[junit4] 2> 2829683 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\tempDir-001/jetty3,
replicaType=NRT, solrconfig=solrconfig.xml, hostContext=/wcax/kr,
hostPort=56565,
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\shard-3-001\cores}
[junit4] 2> 2829683 ERROR
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2829683 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.2.0
[junit4] 2> 2829683 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2829683 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2829683 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-11-09T09:54:18.086Z
[junit4] 2> 2829687 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 2829687 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\shard-3-001\solr.xml
[junit4] 2> 2829693 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay
is ignored
[junit4] 2> 2829694 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter
autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 2829694 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@1ab42e41, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 2829699 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56510/solr
[junit4] 2> 2829709 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56565_wcax%2Fkr ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (0) -> (3)
[junit4] 2> 2829711 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56565_wcax%2Fkr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2829712 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56565_wcax%2Fkr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:56565_wcax%2Fkr
[junit4] 2> 2829714 INFO
(zkCallback-5384-thread-2-processing-n:127.0.0.1:56517_wcax%2Fkr)
[n:127.0.0.1:56517_wcax%2Fkr ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (3) -> (4)
[junit4] 2> 2829714 INFO (zkCallback-5392-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2829714 INFO
(zkCallback-5403-thread-1-processing-n:127.0.0.1:56552_wcax%2Fkr)
[n:127.0.0.1:56552_wcax%2Fkr ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (3) -> (4)
[junit4] 2> 2829714 INFO
(zkCallback-5397-thread-1-processing-n:127.0.0.1:56539_wcax%2Fkr)
[n:127.0.0.1:56539_wcax%2Fkr ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (3) -> (4)
[junit4] 2> 2829714 INFO
(zkCallback-5409-thread-1-processing-n:127.0.0.1:56565_wcax%2Fkr)
[n:127.0.0.1:56565_wcax%2Fkr ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (3) -> (4)
[junit4] 2> 2829811 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56565_wcax%2Fkr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1ab42e41
[junit4] 2> 2829818 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56565_wcax%2Fkr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1ab42e41
[junit4] 2> 2829818 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56565_wcax%2Fkr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1ab42e41
[junit4] 2> 2829819 INFO
(TEST-TestDistribDocBasedVersion.test-seed#[37102F90235AD330])
[n:127.0.0.1:56565_wcax%2Fkr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\shard-3-001\cores
[junit4] 2> 2829853 INFO (qtp476055614-30763)
[n:127.0.0.1:56517_wcax%2Fkr ] o.a.s.h.a.CollectionsHandler Invoked
Collection Action :addreplica with params
node=127.0.0.1:56565_wcax%252Fkr&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2829854 INFO
(OverseerCollectionConfigSetProcessor-98973859670786052-127.0.0.1:56517_wcax%2Fkr-n_0000000000)
[n:127.0.0.1:56517_wcax%2Fkr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000006 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 2829857 INFO
(OverseerThreadFactory-11706-thread-5-processing-n:127.0.0.1:56517_wcax%2Fkr)
[n:127.0.0.1:56517_wcax%2Fkr ] o.a.s.c.AddReplicaCmd Node Identified
127.0.0.1:56565_wcax%2Fkr for creating new replica
[junit4] 2> 2829859 INFO (qtp1189696680-30867)
[n:127.0.0.1:56565_wcax%2Fkr ] o.a.s.h.a.CoreAdminOperation core create
command
qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_n45&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2829860 INFO (qtp1189696680-30867)
[n:127.0.0.1:56565_wcax%2Fkr ] o.a.s.c.TransientSolrCoreCacheDefault
Allocating transient cache for 4 transient cores
[junit4] 2> 2830879 INFO (qtp1189696680-30867)
[n:127.0.0.1:56565_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n45] o.a.s.c.SolrConfig Using Lucene MatchVersion:
7.2.0
[junit4] 2> 2830886 INFO (qtp1189696680-30867)
[n:127.0.0.1:56565_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n45] o.a.s.s.IndexSchema
[collection1_shard2_replica_n45] Schema name=test
[junit4] 2> 2830947 INFO (qtp1189696680-30867)
[n:127.0.0.1:56565_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n45] o.a.s.s.IndexSchema Loaded schema test/1.6
with uniqueid field id
[junit4] 2> 2830960 INFO (qtp1189696680-30867)
[n:127.0.0.1:56565_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n45] o.a.s.c.CoreContainer Creating SolrCore
'collection1_shard2_replica_n45' using configuration from collection
collection1, trusted=true
[junit4] 2> 2830960 INFO (qtp1189696680-30867)
[n:127.0.0.1:56565_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n45] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.collection1.shard2.replica_n45' (registry
'solr.core.collection1.shard2.replica_n45') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1ab42e41
[junit4] 2> 2830960 INFO (qtp1189696680-30867)
[n:127.0.0.1:56565_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n45] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 2830960 INFO (qtp1189696680-30867)
[n:127.0.0.1:56565_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n45] o.a.s.c.SolrCore
[[collection1_shard2_replica_n45] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\shard-3-001\cores\collection1_shard2_replica_n45],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestDistribDocBasedVersion_37102F90235AD330-001\shard-3-001\cores\collection1_shard2_replica_n45\data\]
[junit4] 2> 2830965 INFO (qtp1189696680-30867)
[n:127.0.0.1:56565_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n45] o.a.s.u.RandomMergePolicy RandomMergePolicy
wrapping class org.apache.lucene.index.AlcoholicMergePolicy:
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=921266246,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 2831029 INFO (qtp1189696680-30867)
[n:127.0.0.1:56565_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n45] o.a.s.u.UpdateHandler Using UpdateLog
implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 2831029 INFO (qtp1189696680-30867)
[n:127.0.0.1:56565_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n45] o.a.s.u.UpdateLog Initializing UpdateLog:
dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 2831030 INFO (qtp1189696680-30867)
[n:127.0.0.1:56565_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n45] o.a.s.u.CommitTracker Hard AutoCommit:
disabled
[junit4] 2> 2831030 INFO (qtp1189696680-30867)
[n:127.0.0.1:56565_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n45] o.a.s.u.CommitTracker Soft AutoCommit:
disabled
[junit4] 2> 2831031 INFO (qtp1189696680-30867)
[n:127.0.0.1:56565_wcax%2Fkr c:collection1 s:shard2
x:collection1_shard2_replica_n45] o.a.s.u.RandomMergePolicy RandomMergePolicy
wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [Alco
[...truncated too long message...]
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:897)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[junit4] 2> at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
[junit4] 2> at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2>
[junit4] 2> 16702 T63 n:n:88.99.242.118:8983_
oasc.ZkController.publishNodeAsDown WARN Could not publish node as down:
org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode =
Session expired for /overseer
[junit4] 2> 16702 T63 n:n:88.99.242.118:8983_
oasc.ZkController.removeEphemeralLiveNode Remove node as live in
ZooKeeper:/live_nodes/88.99.242.118:8983_
[junit4] 2> 16702 T63 n:n:88.99.242.118:8983_ oasc.CoreContainer.shutdown
WARN Error removing live node. Continuing to close CoreContainer
org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode =
Session expired for /autoscaling/nodeAdded/88.99.242.118:8983_
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at
org.apache.zookeeper.ZooKeeper.exists(ZooKeeper.java:1102)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient.lambda$exists$3(SolrZkClient.java:308)
[junit4] 2> at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient.exists(SolrZkClient.java:308)
[junit4] 2> at
org.apache.solr.cloud.ZkController.removeEphemeralLiveNode(ZkController.java:989)
[junit4] 2> at
org.apache.solr.core.CoreContainer.shutdown(CoreContainer.java:747)
[junit4] 2> at
org.apache.solr.util.TestHarness.close(TestHarness.java:384)
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.deleteCore(SolrTestCaseJ4.java:791)
[junit4] 2> at
org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:291)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native
Method)
[junit4] 2> at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] 2> at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:897)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[junit4] 2> at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
[junit4] 2> at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2>
[junit4] 2> 16703 T63 n:n:88.99.242.118:8983_
oasm.SolrMetricManager.closeReporters Closing metric reporters for
registry=solr.cluster, tag=null
[junit4] 2> 16704 T63 n:n:88.99.242.118:8983_
oas.SolrTestCaseJ4.clearObjectTrackerAndCheckEmpty
------------------------------------------------------- Done waiting for
tracked resources to be released
[junit4] 2> Nov 09, 2017 10:20:40 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 2 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Lucene70,
sim=RandomSimilarity(queryNorm=true): {}, locale=ar-YE, timezone=Africa/Freetown
[junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 1.8.0_144
(64-bit)/cpus=3,threads=1,free=73972920,total=98041856
[junit4] 2> NOTE: All tests run in this JVM: [TestWriterImpl,
TestZKPropertiesWriter]
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=TestZKPropertiesWriter -Dtests.seed=F5950F6308857AC2
-Dtests.slow=true -Dtests.locale=ar-YE -Dtests.timezone=Africa/Freetown
-Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.00s J0 | TestZKPropertiesWriter (suite) <<<
[junit4] > Throwable #1: java.io.IOException: Could not remove the
following files (in the order of attempts):
[junit4] >
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestZKPropertiesWriter_F5950F6308857AC2-001\zkData-001\version-2:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestZKPropertiesWriter_F5950F6308857AC2-001\zkData-001\version-2
[junit4] >
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestZKPropertiesWriter_F5950F6308857AC2-001\zkData-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestZKPropertiesWriter_F5950F6308857AC2-001\zkData-001
[junit4] >
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestZKPropertiesWriter_F5950F6308857AC2-001\zkData-001\version-2\log.1:
java.nio.file.AccessDeniedException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestZKPropertiesWriter_F5950F6308857AC2-001\zkData-001\version-2\log.1
[junit4] >
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestZKPropertiesWriter_F5950F6308857AC2-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-dataimporthandler\test\J0\temp\solr.handler.dataimport.TestZKPropertiesWriter_F5950F6308857AC2-001
[junit4] > at
__randomizedtesting.SeedInfo.seed([F5950F6308857AC2]:0)
[junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] Completed [5/38 (1!)] on J0 in 4.44s, 1 test, 1 error <<< FAILURES!
[...truncated 41870 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
