Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-master/1121/
No tests ran.
Build Log:
[...truncated 1895 lines...]
[junit4] Suite: org.apache.lucene.search.TestFuzzyQuery
[junit4] 2> 9월 25, 2016 4:08:54 오전
com.carrotsearch.randomizedtesting.ThreadLeakControl$2 evaluate
[junit4] 2> WARNING: Suite execution timed out:
org.apache.lucene.search.TestFuzzyQuery
[junit4] 2> 1) Thread[id=2972,
name=SUITE-TestFuzzyQuery-seed#[AEF39117F58BD628], state=RUNNABLE,
group=TGRP-TestFuzzyQuery]
[junit4] 2> at java.lang.Thread.getStackTrace(Thread.java:1556)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$4.run(ThreadLeakControl.java:688)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$4.run(ThreadLeakControl.java:685)
[junit4] 2> at java.security.AccessController.doPrivileged(Native
Method)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl.getStackTrace(ThreadLeakControl.java:685)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl.getThreadsWithTraces(ThreadLeakControl.java:701)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl.formatThreadStacksFull(ThreadLeakControl.java:681)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl.access$1000(ThreadLeakControl.java:64)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$2.evaluate(ThreadLeakControl.java:414)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSuite(RandomizedRunner.java:681)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.access$200(RandomizedRunner.java:140)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$2.run(RandomizedRunner.java:591)
[junit4] 2> 2) Thread[id=1, name=main, state=WAITING, group=main]
[junit4] 2> at java.lang.Object.wait(Native Method)
[junit4] 2> at java.lang.Thread.join(Thread.java:1249)
[junit4] 2> at java.lang.Thread.join(Thread.java:1323)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSuite(RandomizedRunner.java:601)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.run(RandomizedRunner.java:450)
[junit4] 2> at
com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:243)
[junit4] 2> at
com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:354)
[junit4] 2> at
com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:10)
[junit4] 2> 3) Thread[id=9, name=JUnit4-serializer-daemon,
state=TIMED_WAITING, group=main]
[junit4] 2> at java.lang.Thread.sleep(Native Method)
[junit4] 2> at
com.carrotsearch.ant.tasks.junit4.events.Serializer$1.run(Serializer.java:47)
[junit4] 2> 4) Thread[id=2973,
name=TEST-TestFuzzyQuery.testRandom-seed#[AEF39117F58BD628], state=RUNNABLE,
group=TGRP-TestFuzzyQuery]
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedContext.context(RandomizedContext.java:254)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedContext.current(RandomizedContext.java:151)
[junit4] 2> at
org.apache.lucene.util.LuceneTestCase.random(LuceneTestCase.java:730)
[junit4] 2> at
org.apache.lucene.search.TestFuzzyQuery.randomSimpleString(TestFuzzyQuery.java:506)
[junit4] 2> at
org.apache.lucene.search.TestFuzzyQuery.testRandom(TestFuzzyQuery.java:517)
[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:1764)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
[junit4] 2> at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
[junit4] 2> at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
[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:367)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> NOTE: download the large Jenkins line-docs file by running
'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestFuzzyQuery
-Dtests.method=testRandom -Dtests.seed=AEF39117F58BD628 -Dtests.multiplier=2
-Dtests.nightly=true -Dtests.slow=true
-Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/test-data/enwiki.random.lines.txt
-Dtests.locale=ko-KR -Dtests.timezone=Africa/Mogadishu -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[junit4] ERROR 7200s J2 | TestFuzzyQuery.testRandom <<<
[junit4] > Throwable #1: java.lang.Exception: Test abandoned because
suite timeout was reached.
[junit4] > at
__randomizedtesting.SeedInfo.seed([AEF39117F58BD628]:0)
[junit4] 2> 9월 25, 2016 4:08:54 오전
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> 9월 25, 2016 4:09:14 오전
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> SEVERE: 1 thread leaked from SUITE scope at
org.apache.lucene.search.TestFuzzyQuery:
[junit4] 2> 1) Thread[id=2973,
name=TEST-TestFuzzyQuery.testRandom-seed#[AEF39117F58BD628], state=RUNNABLE,
group=TGRP-TestFuzzyQuery]
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedContext.current(RandomizedContext.java:151)
[junit4] 2> at
org.apache.lucene.util.LuceneTestCase.random(LuceneTestCase.java:730)
[junit4] 2> at
org.apache.lucene.search.TestFuzzyQuery.randomSimpleString(TestFuzzyQuery.java:506)
[junit4] 2> at
org.apache.lucene.search.TestFuzzyQuery.testRandom(TestFuzzyQuery.java:517)
[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:1764)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
[junit4] 2> at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
[junit4] 2> at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
[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:367)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 9월 25, 2016 4:09:14 오전
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: Starting to interrupt leaked threads:
[junit4] 2> 1) Thread[id=2973,
name=TEST-TestFuzzyQuery.testRandom-seed#[AEF39117F58BD628], state=RUNNABLE,
group=TGRP-TestFuzzyQuery]
[junit4] 2> 9월 25, 2016 4:09:17 오전
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> SEVERE: There are still zombie threads that couldn't be
terminated:
[junit4] 2> 1) Thread[id=2973,
name=TEST-TestFuzzyQuery.testRandom-seed#[AEF39117F58BD628], state=RUNNABLE,
group=TGRP-TestFuzzyQuery]
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedContext.getRandomness(RandomizedContext.java:110)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedContext.getRandom(RandomizedContext.java:132)
[junit4] 2> at
org.apache.lucene.util.LuceneTestCase.random(LuceneTestCase.java:730)
[junit4] 2> at
org.apache.lucene.search.TestFuzzyQuery.randomSimpleString(TestFuzzyQuery.java:506)
[junit4] 2> at
org.apache.lucene.search.TestFuzzyQuery.testRandom(TestFuzzyQuery.java:517)
[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:1764)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
[junit4] 2> at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
[junit4] 2> at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
[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:367)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62):
{field=PostingsFormat(name=Memory doPackFST= false)}, docValues:{},
maxPointsInLeafNode=1489, maxMBSortInHeap=7.472815105601821,
sim=RandomSimilarity(queryNorm=true): {field=DFR I(F)B3(800.0)}, locale=ko-KR,
timezone=Africa/Mogadishu
[junit4] 2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation
1.8.0_102 (64-bit)/cpus=4,threads=2,free=276095768,total=426770432
[junit4] 2> NOTE: All tests run in this JVM:
[TestParallelReaderEmptyIndex, TestSingleInstanceLockFactory,
TestBlockPostingsFormat, TestStressIndexing, TestAtomicUpdate,
TestIndexWriterDeleteByQuery, TestBytesRefArray, TestToken,
TestCodecHoldsOpenFiles, Test2BBinaryDocValues, TestCachingCollector,
TestDocumentWriter, TestIndexWriterMergePolicy, TestArrayUtil, TestNot,
TestNotDocIdSet, TestRegexpRandom2, TestIndexInput, TestInPlaceMergeSorter,
TestTermsEnum, TestFilterWeight, TestSpanFirstQuery, TestSameScoresWithThreads,
TestCollectionUtil, TestConjunctionDISI, TestIndexWriterExceptions,
TestSparseFixedBitSet, TestMatchNoDocsQuery, TestUpgradeIndexMergePolicy,
TestBinaryTerms, TestSimpleSearchEquivalence, TestReaderWrapperDVTypeCheck,
TestNoMergeScheduler, TestSegmentTermDocs, TestIndexWriterReader,
TestNRTCachingDirectory, TestSegmentMerger, TestTopDocsMerge, TestTerms,
TestRegexpRandom, TestIntroSorter, TestDocIdsWriter, TestTermQuery,
TestFixedBitDocIdSet, TestDirectMonotonic, TestTransactionRollback,
TestIntsRef, TestTransactions, TestVirtualMethod,
TestIndexWriterThreadsToSegments, TestHighCompressionMode, TestLogMergePolicy,
TestSpanCollection, TestBlendedTermQuery, TestPointQueries, TestGeoUtils,
LimitedFiniteStringsIteratorTest, TestParallelTermEnum,
TestSnapshotDeletionPolicy, TestMergeSchedulerExternal, TestIndexWriterMaxDocs,
TestOrdinalMap, TestWordlistLoader, TestDocInverterPerFieldErrorInfo,
TestSpans, TestRateLimiter, TestTwoPhaseCommitTool, TestDocValuesScoring,
TestLazyProxSkipping, TestMultiTermsEnum, TestWildcard, TestIndexWriterMerging,
TestFSTs, TestMultiMMap, TestDeletionPolicy, TestFlushByRamOrCountsPolicy,
TestIndexWriterDelete, TestNRTThreads, TestMultiThreadTermVectors, TestSort,
TestMultiDocValues, TestSpanExplanations, TestStressIndexing2, TestCodecs,
TestParallelLeafReader, TestSloppyPhraseQuery2, TestFuzzyQuery]
[junit4] 2> NOTE: download the large Jenkins line-docs file by running
'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestFuzzyQuery
-Dtests.seed=AEF39117F58BD628 -Dtests.multiplier=2 -Dtests.nightly=true
-Dtests.slow=true
-Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/test-data/enwiki.random.lines.txt
-Dtests.locale=ko-KR -Dtests.timezone=Africa/Mogadishu -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J2 | TestFuzzyQuery (suite) <<<
[junit4] > Throwable #1: java.lang.Exception: Suite timeout exceeded (>=
7200000 msec).
[junit4] > at
__randomizedtesting.SeedInfo.seed([AEF39117F58BD628]:0)
[junit4] Completed [433/433 (1!)] on J2 in 7223.45s, 11 tests, 2 errors <<<
FAILURES!
[...truncated 9384 lines...]
[junit4] Suite: org.apache.solr.update.SoftAutoCommitTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.update.SoftAutoCommitTest_BF4DC0948A35D7ED-001/init-core-data-001
[junit4] 2> 13712 INFO
(SUITE-SoftAutoCommitTest-seed#[BF4DC0948A35D7ED]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 13713 INFO
(SUITE-SoftAutoCommitTest-seed#[BF4DC0948A35D7ED]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 13714 INFO
(SUITE-SoftAutoCommitTest-seed#[BF4DC0948A35D7ED]-worker) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib,
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 14233 WARN
(SUITE-SoftAutoCommitTest-seed#[BF4DC0948A35D7ED]-worker) [ ] o.a.s.c.Config
Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory>
instead.
[junit4] 2> 14256 INFO
(SUITE-SoftAutoCommitTest-seed#[BF4DC0948A35D7ED]-worker) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 14628 INFO
(SUITE-SoftAutoCommitTest-seed#[BF4DC0948A35D7ED]-worker) [ ]
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 14842 INFO
(SUITE-SoftAutoCommitTest-seed#[BF4DC0948A35D7ED]-worker) [ ]
o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 16984 INFO
(SUITE-SoftAutoCommitTest-seed#[BF4DC0948A35D7ED]-worker) [ ]
o.a.s.s.IndexSchema [null] default search field in schema is text. WARNING:
Deprecated, please use 'df' on request instead.
[junit4] 2> 16986 INFO
(SUITE-SoftAutoCommitTest-seed#[BF4DC0948A35D7ED]-worker) [ ]
o.a.s.s.IndexSchema [null] unique key field: id
[junit4] 2> 17407 INFO (coreLoadExecutor-18-thread-1) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib,
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 17567 WARN (coreLoadExecutor-18-thread-1) [ ]
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use
<mergePolicyFactory> instead.
[junit4] 2> 17569 INFO (coreLoadExecutor-18-thread-1) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 17685 INFO (coreLoadExecutor-18-thread-1) [ ]
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 18076 INFO (coreLoadExecutor-18-thread-1) [ ]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 18406 INFO (coreLoadExecutor-18-thread-1) [ ]
o.a.s.s.IndexSchema [collection1] default search field in schema is text.
WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 18407 INFO (coreLoadExecutor-18-thread-1) [ ]
o.a.s.s.IndexSchema [collection1] unique key field: id
[junit4] 2> 18540 INFO (coreLoadExecutor-18-thread-1) [ ]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
instancedir
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1
[junit4] 2> 18541 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.update.SoftAutoCommitTest_BF4DC0948A35D7ED-001/init-core-data-001/]
[junit4] 2> 18561 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.c.SolrCore New index directory detected: old=null
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.update.SoftAutoCommitTest_BF4DC0948A35D7ED-001/init-core-data-001/index/
[junit4] 2> 18562 WARN (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Solr index directory
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.update.SoftAutoCommitTest_BF4DC0948A35D7ED-001/init-core-data-001/index'
doesn't exist. Creating new index...
[junit4] 2> 18562 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=29, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 18581 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1ccd07a0
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@417b113),segFN=segments_1,generation=1}
[junit4] 2> 18581 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 18589 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.c.PluginBag [collection1] Initialized 1 plugins of type
queryResponseWriter: [xml]
[junit4] 2> 18618 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.c.PluginBag [collection1] Initialized 1 plugins of type queryParser: [foo]
[junit4] 2> 18755 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.c.PluginBag [collection1] Initialized 4 plugins of type searchComponent:
[spellcheck, termsComp, tvComponent, highlight]
[junit4] 2> 18755 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"dedupe"
[junit4] 2> 18786 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 18802 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 18802 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 18802 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"stored_sig"
[junit4] 2> 18803 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 18803 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"uniq-fields"
[junit4] 2> 18807 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 18807 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"distrib-dup-test-chain-explicit"
[junit4] 2> 18851 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 18857 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 19028 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.c.PluginBag [collection1] Initialized 39 plugins of type requestHandler:
[/update, /update/json, /update/csv, /update/json/docs, /config, /schema,
/replication, /get, /admin/ping, /admin/segments, /admin/luke, /admin/system,
/admin/mbeans, /admin/plugins, /admin/threads, /admin/properties,
/admin/logging, /admin/file, /export, /graph, /stream, /sql, /terms, standard,
dismax, mock, defaults, lazy, spellCheckCompRH, spellCheckCompRH_Direct,
spellCheckWithWordbreak, spellCheckWithWordbreak_Direct, spellCheckCompRH1,
mltrh, tvrh, /mlt, /debug/dump, /search-facet-def, /search-facet-invariants]
[junit4] 2> 19028 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.c.RequestHandlers Registered paths:
/admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,/export,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/sql,/graph,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump
[junit4] 2> 19046 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 19046 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 19067 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 19068 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 19068 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=45, maxMergeAtOnceExplicit=45, maxMergedSegmentMB=97.3837890625,
floorSegmentMB=1.2412109375, forceMergeDeletesPctAllowed=25.59226891409414,
segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.8687551454356546
[junit4] 2> 19070 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1ccd07a0
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@417b113),segFN=segments_1,generation=1}
[junit4] 2> 19071 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 19072 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@46d7e4b[collection1] main]
[junit4] 2> 19081 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.r.RestManager Initializing RestManager with initArgs:
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 19082 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 19083 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 19083 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 19246 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 19468 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 19470 INFO
(searcherExecutor-19-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 19474 INFO
(searcherExecutor-19-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 19474 INFO
(searcherExecutor-19-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 19474 INFO
(searcherExecutor-19-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker:
multipleFields
[junit4] 2> 19475 INFO
(searcherExecutor-19-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 19475 INFO
(searcherExecutor-19-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 19476 INFO
(searcherExecutor-19-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 19476 INFO
(searcherExecutor-19-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 19477 INFO
(searcherExecutor-19-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 19477 INFO
(searcherExecutor-19-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@46d7e4b[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 19480 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets
[junit4] 2> 19480 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version
buckets from index
[junit4] 2> 19480 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket
highest value from index
[junit4] 2> 19480 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1546413749740503040
[junit4] 2> 19506 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.u.UpdateLog Took 25.0ms to seed version buckets with highest version
1546413749740503040
[junit4] 2> 19509 INFO
(SUITE-SoftAutoCommitTest-seed#[BF4DC0948A35D7ED]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 19512 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testSoftAndHardCommitMaxTimeDelete
[junit4] 2> 19513 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from
paths:
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib,
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 20046 WARN
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated,
use <mergePolicyFactory> instead.
[junit4] 2> 20055 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 20123 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 20213 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 21003 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ ] o.a.s.s.IndexSchema [collection1] default search field in schema is
text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 21004 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ ] o.a.s.s.IndexSchema [collection1] unique key field: id
[junit4] 2> 21118 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ ] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using
configuration from instancedir
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1
[junit4] 2> 21119 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.update.SoftAutoCommitTest_BF4DC0948A35D7ED-001/init-core-data-001/]
[junit4] 2> 21120 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.update.SoftAutoCommitTest_BF4DC0948A35D7ED-001/init-core-data-001/index/
[junit4] 2> 21121 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.PluginBag [collection1] Initialized 1 plugins of
type queryResponseWriter: [xml]
[junit4] 2> 21124 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.PluginBag [collection1] Initialized 1 plugins of
type queryParser: [foo]
[junit4] 2> 21132 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.PluginBag [collection1] Initialized 4 plugins of
type searchComponent: [spellcheck, termsComp, tvComponent, highlight]
[junit4] 2> 21133 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 21149 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 21149 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 21149 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 21150 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 21163 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 21163 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "uniq-fields"
[junit4] 2> 21184 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 21184 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 21184 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 21185 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 21217 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.PluginBag [collection1] Initialized 39 plugins of
type requestHandler: [/update, /update/json, /update/csv, /update/json/docs,
/config, /schema, /replication, /get, /admin/ping, /admin/segments,
/admin/luke, /admin/system, /admin/mbeans, /admin/plugins, /admin/threads,
/admin/properties, /admin/logging, /admin/file, /export, /graph, /stream, /sql,
/terms, standard, dismax, mock, defaults, lazy, spellCheckCompRH,
spellCheckCompRH_Direct, spellCheckWithWordbreak,
spellCheckWithWordbreak_Direct, spellCheckCompRH1, mltrh, tvrh, /mlt,
/debug/dump, /search-facet-def, /search-facet-invariants]
[junit4] 2> 21218 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.RequestHandlers Registered paths:
/admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,/export,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/sql,/graph,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump
[junit4] 2> 21224 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 21224 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 21232 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@4e9d835[collection1] main]
[junit4] 2> 21233 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.r.RestManager Initializing RestManager with
initArgs:
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 21233 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json
using InMemoryStorage
[junit4] 2> 21233 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.r.RestManager Initializing 0 registered
ManagedResources
[junit4] 2> 21234 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 21240 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 21261 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for
10000
[junit4] 2> 21261 INFO
(searcherExecutor-24-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 21262 INFO
(searcherExecutor-24-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 21262 INFO
(searcherExecutor-24-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 21262 INFO
(searcherExecutor-24-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker:
multipleFields
[junit4] 2> 21262 INFO
(searcherExecutor-24-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 21263 INFO
(searcherExecutor-24-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 21263 INFO
(searcherExecutor-24-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 21263 INFO
(searcherExecutor-24-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 21264 INFO
(searcherExecutor-24-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 21264 INFO
(searcherExecutor-24-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@4e9d835[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 21264 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to
seed version buckets
[junit4] 2> 21265 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_
for 65536 version buckets from index
[junit4] 2> 21265 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot
seed version bucket highest value from index
[junit4] 2> 21265 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or
recent updates, using new clock 1546413751612211200
[junit4] 2> 21268 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.UpdateLog Took 3.0ms to seed version buckets with
highest version 1546413751612211200
[junit4] 2> 21271 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.DefaultSolrCoreState Closing old IndexWriter...
core=collection1
[junit4] 2> 21288 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@2e8d29de
[junit4] 2> 21289 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit:
commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1ccd07a0
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@417b113),segFN=segments_1,generation=1}
[junit4] 2> 21289 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 21289 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to
be used.
[junit4] 2> 21290 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@4b49546e[collection1] main]
[junit4] 2> 21290 INFO
(searcherExecutor-24-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@4b49546e[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 21291 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@5c4c6b29
[junit4] 2> 21291 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.DirectUpdateHandler2 closing
DirectUpdateHandler2{commits=0,autocommits=0,soft
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
[junit4] 2> 21291 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on
request.
[junit4] 2> 21560 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]
webapp=null path=null params={}{add=[529 (1546413751642619904)]} 0 267
[junit4] 2> 21615 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 21615 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@3b468ce5
[junit4] 2> 21744 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit:
commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1ccd07a0
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@417b113),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1ccd07a0
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@417b113),segFN=segments_2,generation=2}
[junit4] 2> 21744 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 2
[junit4] 2> 21751 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@6474949a[collection1] main]
[junit4] 2> 21751 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 21751 INFO
(searcherExecutor-24-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@6474949a[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c1)))}
[junit4] 2> 21776 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]
webapp=null path=null params={}{commit=} 0 161
[junit4] 2> 21785 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]
webapp=null path=null params={}{delete=[529 (-1546413752149082112)]} 0 7
[junit4] 2> 22285 INFO (commitScheduler-27-thread-1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 22332 INFO (commitScheduler-27-thread-1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@5e7985b7[collection1] main]
[junit4] 2> 22333 INFO
(searcherExecutor-24-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@5e7985b7[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 22338 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]
webapp=null path=null params={}{add=[550 (1546413752734187520)]} 0 3
[junit4] 2> 22345 INFO (commitScheduler-27-thread-1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 22844 INFO (commitScheduler-27-thread-1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 22996 INFO (commitScheduler-26-thread-1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 23036 INFO (commitScheduler-27-thread-1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@72c4be05[collection1] main]
[junit4] 2> 23038 INFO
(searcherExecutor-24-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@72c4be05[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.0.0):c1)))}
[junit4] 2> 23038 INFO (commitScheduler-26-thread-1) [ x:collection1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@3b468ce5
[junit4] 2> 23039 INFO (commitScheduler-26-thread-1) [ x:collection1]
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1ccd07a0
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@417b113),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1ccd07a0
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@417b113),segFN=segments_3,generation=3}
[junit4] 2> 23039 INFO (commitScheduler-26-thread-1) [ x:collection1]
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
[junit4] 2> 23040 INFO (commitScheduler-26-thread-1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@183a7b14[collection1] main]
[junit4] 2> 23040 INFO
(searcherExecutor-24-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@183a7b14[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.0.0):c1)))}
[junit4] 2> 23041 INFO (commitScheduler-26-thread-1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 23044 INFO (commitScheduler-27-thread-1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 25040 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.SolrTestCaseJ4 ###Ending
testSoftAndHardCommitMaxTimeDelete
[junit4] 2> NOTE: download the large Jenkins line-docs file by running
'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SoftAutoCommitTest
-Dtests.method=testSoftAndHardCommitMaxTimeDelete -Dtests.seed=BF4DC0948A35D7ED
-Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true
-Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/test-data/enwiki.random.lines.txt
-Dtests.locale=ar-IQ -Dtests.timezone=Etc/GMT-8 -Dtests.asserts=true
-Dtests.file.encoding=US-ASCII
[junit4] FAILURE 5.55s J1 |
SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete <<<
[junit4] > Throwable #1: java.lang.AssertionError: Got a soft commit we
weren't expecting
[junit4] > at
__randomizedtesting.SeedInfo.seed([BF4DC0948A35D7ED:78017809919D1A5D]:0)
[junit4] > at
org.apache.solr.update.SoftAutoCommitTest.testSoftAndHardCommitMaxTimeDelete(SoftAutoCommitTest.java:287)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 25068 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.SolrTestCaseJ4 ###Starting
testSoftAndHardCommitMaxTimeMixedAdds
[junit4] 2> 25081 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to
classloader, from paths:
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib,
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 25160 WARN
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is
deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 25162 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 25184 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 25199 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 25600 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.s.IndexSchema [collection1] default search field in
schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 25625 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.s.IndexSchema [collection1] unique key field: id
[junit4] 2> 25734 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.CoreContainer Reloading SolrCore 'collection1'
using configuration from instancedir
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1
[junit4] 2> 25735 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.update.SoftAutoCommitTest_BF4DC0948A35D7ED-001/init-core-data-001/]
[junit4] 2> 25752 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.update.SoftAutoCommitTest_BF4DC0948A35D7ED-001/init-core-data-001/index/
[junit4] 2> 25760 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.PluginBag [collection1] Initialized 1 plugins of
type queryResponseWriter: [xml]
[junit4] 2> 25762 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.PluginBag [collection1] Initialized 1 plugins of
type queryParser: [foo]
[junit4] 2> 25763 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.PluginBag [collection1] Initialized 4 plugins of
type searchComponent: [spellcheck, termsComp, tvComponent, highlight]
[junit4] 2> 25764 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 25764 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 25764 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 25764 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 25764 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 25765 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 25765 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "uniq-fields"
[junit4] 2> 25766 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 25766 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 25766 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 25766 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 25803 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.PluginBag [collection1] Initialized 39 plugins of
type requestHandler: [/update, /update/json, /update/csv, /update/json/docs,
/config, /schema, /replication, /get, /admin/ping, /admin/segments,
/admin/luke, /admin/system, /admin/mbeans, /admin/plugins, /admin/threads,
/admin/properties, /admin/logging, /admin/file, /export, /graph, /stream, /sql,
/terms, standard, dismax, mock, defaults, lazy, spellCheckCompRH,
spellCheckCompRH_Direct, spellCheckWithWordbreak,
spellCheckWithWordbreak_Direct, spellCheckCompRH1, mltrh, tvrh, /mlt,
/debug/dump, /search-facet-def, /search-facet-invariants]
[junit4] 2> 25803 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.RequestHandlers Registered paths:
/admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,/export,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/sql,/graph,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump
[junit4] 2> 25910 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 25910 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 25910 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@3419a255[collection1] main]
[junit4] 2> 25911 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.r.RestManager Initializing RestManager with
initArgs:
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 25911 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json
using InMemoryStorage
[junit4] 2> 25911 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.r.RestManager Initializing 0 registered
ManagedResources
[junit4] 2> 25911 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 25928 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 25957 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for
10000
[junit4] 2> 25958 INFO
(searcherExecutor-28-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 25959 INFO
(searcherExecutor-28-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 25959 INFO
(searcherExecutor-28-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 25959 INFO
(searcherExecutor-28-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker:
multipleFields
[junit4] 2> 25959 INFO
(searcherExecutor-28-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 25960 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to
seed version buckets
[junit4] 2> 25964 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_
for 65536 version buckets from index
[junit4] 2> 25964 INFO
(searcherExecutor-28-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 25964 INFO
(searcherExecutor-28-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 25965 INFO
(searcherExecutor-28-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 25965 INFO
(searcherExecutor-28-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 25965 INFO
(searcherExecutor-28-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@3419a255[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.0.0):c1)))}
[junit4] 2> 25979 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.VersionInfo Found MAX value 1546413752734187520
from Terms for _version_ in index
[junit4] 2> 25983 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.UpdateLog Took 23.0ms to seed version buckets with
highest version 1546413752734187520
[junit4] 2> 25998 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.DefaultSolrCoreState Closing old IndexWriter...
core=collection1
[junit4] 2> 26000 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=20, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.4716157541174105]
[junit4] 2> 26007 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit:
commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1ccd07a0
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@417b113),segFN=segments_3,generation=3}
[junit4] 2> 26007 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 3
[junit4] 2> 26007 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to
be used.
[junit4] 2> 26012 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@23be85e3[collection1] main]
[junit4] 2> 26013 INFO
(searcherExecutor-28-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@23be85e3[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.0.0):c1)))}
[junit4] 2> 26013 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@e0c4225
[junit4] 2> 26017 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.DirectUpdateHandler2 closing
DirectUpdateHandler2{commits=4,autocommit maxTime=1200ms,autocommits=1,soft
autocommit maxTime=500ms,soft
autocommits=2,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=2,cumulative_deletesById=1,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=294,transaction_logs_total_number=2}
[junit4] 2> 26024 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on
request.
[junit4] 2> 26044 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]
webapp=null path=null params={}{add=[529 (1546413756604481536)]} 0 18
[junit4] 2> 26732 INFO (commitScheduler-31-thread-1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 26761 INFO (commitScheduler-31-thread-1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@69703024[collection1] main]
[junit4] 2> 26762 INFO
(searcherExecutor-28-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@69703024[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.0.0):c1)
Uninverting(_2(7.0.0):c1)))}
[junit4] 2> 26763 INFO (commitScheduler-31-thread-1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 26774 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]
webapp=null path=null params={}{add=[530 (1546413757386719232)]} 0 2
[junit4] 2> 27256 INFO (commitScheduler-30-thread-1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 27256 INFO (commitScheduler-30-thread-1) [ x:collection1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@334ba346
[junit4] 2> 27294 INFO (commitScheduler-30-thread-1) [ x:collection1]
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1ccd07a0
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@417b113),segFN=segments_3,generation=3}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1ccd07a0
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@417b113),segFN=segments_4,generation=4}
[junit4] 2> 27294 INFO (commitScheduler-30-thread-1) [ x:collection1]
o.a.s.c.SolrDeletionPolicy newest commit generation = 4
[junit4] 2> 27297 INFO (commitScheduler-30-thread-1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@601550bb[collection1] main]
[junit4] 2> 27297 INFO (commitScheduler-30-thread-1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 27300 INFO
(searcherExecutor-28-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@601550bb[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.0.0):c1)
Uninverting(_2(7.0.0):c1) Uninverting(_3(7.0.0):c1)))}
[junit4] 2> 30566 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.SolrTestCaseJ4 ###Ending
testSoftAndHardCommitMaxTimeMixedAdds
[junit4] 2> 30569 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.SolrTestCaseJ4 ###Starting
testSoftAndHardCommitMaxTimeRapidAdds
[junit4] 2> 30570 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to
classloader, from paths:
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib,
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 30978 WARN
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is
deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 30985 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 31209 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 31308 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 32195 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.s.IndexSchema [collection1] default search field in
schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 32228 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.s.IndexSchema [collection1] unique key field: id
[junit4] 2> 32379 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.CoreContainer Reloading SolrCore 'collection1'
using configuration from instancedir
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1
[junit4] 2> 32408 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.update.SoftAutoCommitTest_BF4DC0948A35D7ED-001/init-core-data-001/]
[junit4] 2> 32409 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.update.SoftAutoCommitTest_BF4DC0948A35D7ED-001/init-core-data-001/index/
[junit4] 2> 32464 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.PluginBag [collection1] Initialized 1 plugins of
type queryResponseWriter: [xml]
[junit4] 2> 32466 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.PluginBag [collection1] Initialized 1 plugins of
type queryParser: [foo]
[junit4] 2> 32467 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.PluginBag [collection1] Initialized 4 plugins of
type searchComponent: [spellcheck, termsComp, tvComponent, highlight]
[junit4] 2> 32467 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 32467 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 32467 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 32467 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"dedupe-allfields"
[junit4] 2> 32467 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 32467 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 32467 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "uniq-fields"
[junit4] 2> 32468 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 32468 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 32478 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 32479 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 32676 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.PluginBag [collection1] Initialized 39 plugins of
type requestHandler: [/update, /update/json, /update/csv, /update/json/docs,
/config, /schema, /replication, /get, /admin/ping, /admin/segments,
/admin/luke, /admin/system, /admin/mbeans, /admin/plugins, /admin/threads,
/admin/properties, /admin/logging, /admin/file, /export, /graph, /stream, /sql,
/terms, standard, dismax, mock, defaults, lazy, spellCheckCompRH,
spellCheckCompRH_Direct, spellCheckWithWordbreak,
spellCheckWithWordbreak_Direct, spellCheckCompRH1, mltrh, tvrh, /mlt,
/debug/dump, /search-facet-def, /search-facet-invariants]
[junit4] 2> 32677 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.c.RequestHandlers Registered paths:
/admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,/export,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/sql,/graph,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump
[junit4] 2> 32680 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 32680 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 32693 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@2d6d6afc[collection1] main]
[junit4] 2> 32694 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.r.RestManager Initializing RestManager with
initArgs:
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 32694 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json
using InMemoryStorage
[junit4] 2> 32694 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.r.RestManager Initializing 0 registered
ManagedResources
[junit4] 2> 32694 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 32698 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.s.DirectSolrSpellChecker init:
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 32734 INFO
(TEST-SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds-seed#[BF4DC0948A35D7ED])
[ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for
10000
[junit4] 2> 32734 INFO
(searcherExecutor-32-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 32736 INFO
(searcherExecutor-32-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 32736 INFO
(searcherExecutor-32-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[ju
[...truncated too long message...]
til.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] 2> at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 2) Thread[id=256394, name=Connection evictor,
state=TIMED_WAITING, group=TGRP-CdcrVersionReplicationTest]
[junit4] 2> at java.lang.Thread.sleep(Native Method)
[junit4] 2> at
org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> Sep 25, 2016 5:27:13 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: Starting to interrupt leaked threads:
[junit4] 2> 1) Thread[id=256390, name=searcherExecutor-5664-thread-1,
state=WAITING, group=TGRP-CdcrVersionReplicationTest]
[junit4] 2> 2) Thread[id=256394, name=Connection evictor,
state=TIMED_WAITING, group=TGRP-CdcrVersionReplicationTest]
[junit4] 2> Sep 25, 2016 5:27:16 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> SEVERE: There are still zombie threads that couldn't be
terminated:
[junit4] 2> 1) Thread[id=256390, name=searcherExecutor-5664-thread-1,
state=WAITING, group=TGRP-CdcrVersionReplicationTest]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] 2> at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62): {},
docValues:{}, maxPointsInLeafNode=780, maxMBSortInHeap=5.38963644527261,
sim=ClassicSimilarity, locale=es-GT, timezone=Atlantic/Cape_Verde
[junit4] 2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation
1.8.0_102 (64-bit)/cpus=4,threads=2,free=71710832,total=498073600
[junit4] 2> NOTE: All tests run in this JVM: [DisMaxRequestHandlerTest,
SharedFSAutoReplicaFailoverTest, SolrRequestParserTest, TestQuerySenderNoQuery,
TestSolrDeletionPolicy2, TestJmxIntegration, TestSubQueryTransformer,
DistributedQueryElevationComponentTest, TestCloudSchemaless,
TestSolrQueryResponse, TestFieldSortValues, TestRandomDVFaceting,
TestFastWriter, TestJoin, ActionThrottleTest, TestExactStatsCache,
ClusterStateTest, TestSolrCoreProperties, TestAtomicUpdateErrorCases,
AnalysisErrorHandlingTest, TestExclusionRuleCollectionAccess,
TestReloadDeadlock, TestSolr4Spatial, SolrCLIZkUtilsTest,
TestOverriddenPrefixQueryForCustomFieldType, CdcrBootstrapTest,
SuggestComponentTest, DistribCursorPagingTest, CollectionsAPISolrJTest,
DistributedQueueTest, TestConfigSetImmutable, TestFieldTypeResource,
ZkStateReaderTest, TestLeaderInitiatedRecoveryThread, TestFaceting,
MBeansHandlerTest, TestUseDocValuesAsStored2, TestPerFieldSimilarity,
TestSQLHandler, TestBadConfig, DocumentAnalysisRequestHandlerTest,
CleanupOldIndexTest, TestNumericTerms64, VersionInfoTest,
TestMaxScoreQueryParser, TestNonDefinedSimilarityFactory, DeleteReplicaTest,
StatsReloadRaceTest, TestBulkSchemaConcurrent, BasicDistributedZkTest,
TestDistributedSearch, ClassificationUpdateProcessorFactoryTest,
DistributedSpellCheckComponentTest, TestFieldCollectionResource,
ResourceLoaderTest, SolrCoreTest, HighlighterConfigTest, HttpPartitionTest,
TestCodecSupport, BasicZkTest, FastVectorHighlighterTest, TestComponentsName,
LeaderInitiatedRecoveryOnCommitTest, TestFieldCacheWithThreads,
RecoveryAfterSoftCommitTest, TestConfigSetsAPI, TestHashQParserPlugin,
SSLMigrationTest, DateFieldTest, TestManagedStopFilterFactory,
IgnoreCommitOptimizeUpdateProcessorFactoryTest, UUIDFieldTest,
TestNamedUpdateProcessors, TestPivotHelperCode, BooleanFieldTest,
TestCloudPivotFacet, TestCrossCoreJoin, TestRemoteStreaming, PolyFieldTest,
OverseerCollectionConfigSetProcessorTest, TestCryptoKeys, CheckHdfsIndexTest,
RegexBoostProcessorTest, LeaderElectionIntegrationTest, TestDocumentBuilder,
DistributedQueryComponentCustomSortTest, TestFieldCacheSort,
TestDefaultStatsCache, TestGraphMLResponseWriter, CursorMarkTest,
TestTolerantUpdateProcessorCloud, CollectionStateFormat2Test,
TestReplicationHandlerBackup, TestFieldCache, OverseerStatusTest,
DistributedFacetPivotSmallAdvancedTest, TestBinaryResponseWriter,
QueryEqualityTest, StandardRequestHandlerTest,
TestSolrQueryParserDefaultOperatorResource,
BigEndianAscendingWordSerializerTest, TestLazyCores, CursorPagingTest,
CdcrVersionReplicationTest]
[junit4] 2> NOTE: download the large Jenkins line-docs file by running
'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=CdcrVersionReplicationTest -Dtests.seed=BF4DC0948A35D7ED
-Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true
-Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/test-data/enwiki.random.lines.txt
-Dtests.locale=es-GT -Dtests.timezone=Atlantic/Cape_Verde -Dtests.asserts=true
-Dtests.file.encoding=US-ASCII
[junit4] ERROR 0.00s J0 | CdcrVersionReplicationTest (suite) <<<
[junit4] > Throwable #1:
com.carrotsearch.randomizedtesting.ThreadLeakError: 2 threads leaked from SUITE
scope at org.apache.solr.cloud.CdcrVersionReplicationTest:
[junit4] > 1) Thread[id=256390, name=searcherExecutor-5664-thread-1,
state=WAITING, group=TGRP-CdcrVersionReplicationTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] > at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] > at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > 2) Thread[id=256394, name=Connection evictor,
state=TIMED_WAITING, group=TGRP-CdcrVersionReplicationTest]
[junit4] > at java.lang.Thread.sleep(Native Method)
[junit4] > at
org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > at
__randomizedtesting.SeedInfo.seed([BF4DC0948A35D7ED]:0)Throwable #2:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
[junit4] > 1) Thread[id=256390, name=searcherExecutor-5664-thread-1,
state=WAITING, group=TGRP-CdcrVersionReplicationTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] > at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] > at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > at
__randomizedtesting.SeedInfo.seed([BF4DC0948A35D7ED]:0)
[junit4] Completed [467/636 (7!)] on J0 in 787.70s, 1 test, 3 errors <<<
FAILURES!
[...truncated 509 lines...]
[junit4] JVM J1: stdout was not empty, see:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/temp/junit4-J1-20160925_034407_301.sysout
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] java.lang.OutOfMemoryError: GC overhead limit exceeded
[junit4] Dumping heap to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/heapdumps/java_pid25432.hprof
...
[junit4] Heap dump file created [511477987 bytes in 10.210 secs]
[junit4] <<< JVM J1: EOF ----
[...truncated 3535 lines...]
ERROR: Step ‘Archive the artifacts’ failed: no workspace for
Lucene-Solr-NightlyTests-master #1121
ERROR: Step ‘Publish JUnit test result report’ failed: no workspace for
Lucene-Solr-NightlyTests-master #1121
ERROR: lucene is offline; cannot locate JDK 1.8 (latest)
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
ERROR: lucene is offline; cannot locate JDK 1.8 (latest)
ERROR: lucene is offline; cannot locate JDK 1.8 (latest)
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
