You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2016/12/31 17:23:14 UTC
[JENKINS] Lucene-Solr-master-Solaris (64bit/jdk1.8.0) - Build #
1046 - Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Solaris/1046/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseG1GC
1 tests failed.
FAILED: org.apache.lucene.analysis.core.TestRandomChains.testRandomChainsWithLargeStrings
Error Message:
pos=6 nextPos=10 count=3
Stack Trace:
java.lang.AssertionError: pos=6 nextPos=10 count=3
at __randomizedtesting.SeedInfo.seed([30786A43D63AEC6C:5A23D5528F74CC9F]:0)
at org.apache.lucene.util.RollingBuffer.get(RollingBuffer.java:105)
at org.apache.lucene.analysis.synonym.FlattenGraphFilter.releaseBufferedToken(FlattenGraphFilter.java:183)
at org.apache.lucene.analysis.synonym.FlattenGraphFilter.incrementToken(FlattenGraphFilter.java:264)
at org.apache.lucene.analysis.ValidatingTokenFilter.incrementToken(ValidatingTokenFilter.java:67)
at org.apache.lucene.analysis.BaseTokenStreamTestCase.checkAnalysisConsistency(BaseTokenStreamTestCase.java:724)
at org.apache.lucene.analysis.BaseTokenStreamTestCase.checkRandomData(BaseTokenStreamTestCase.java:635)
at org.apache.lucene.analysis.BaseTokenStreamTestCase.checkRandomData(BaseTokenStreamTestCase.java:533)
at org.apache.lucene.analysis.core.TestRandomChains.testRandomChainsWithLargeStrings(TestRandomChains.java:869)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 2177 lines...]
[junit4] Suite: org.apache.lucene.analysis.core.TestRandomChains
[junit4] 2> TEST FAIL: useCharFilter=false text='{1,5}b 10 eaj fishcl \ua707\ua70d\ua710\ua718\ua716\ua70c i EZspcnb janx \u310f\u3115 c \u56fe= k'
[junit4] 2> Exception from random analyzer:
[junit4] 2> charfilters=
[junit4] 2> org.apache.lucene.analysis.charfilter.HTMLStripCharFilter(java.io.StringReader@68fea570, [<HIRAGANA>, <COMPANY>])
[junit4] 2> org.apache.lucene.analysis.charfilter.HTMLStripCharFilter(org.apache.lucene.analysis.charfilter.HTMLStripCharFilter@271a3439, [<NUM>, <CJ>])
[junit4] 2> tokenizer=
[junit4] 2> org.apache.lucene.analysis.standard.UAX29URLEmailTokenizer(org.apache.lucene.util.AttributeFactory$DefaultAttributeFactory@4b2a1fb5)
[junit4] 2> filters=
[junit4] 2> org.apache.lucene.analysis.commongrams.CommonGramsQueryFilter(CommonGramsFilter@3d1ac1b1 term=,bytes=[],startOffset=0,endOffset=0,positionIncrement=1,type=word,positionLength=1)
[junit4] 2> org.apache.lucene.analysis.miscellaneous.KeywordRepeatFilter(ValidatingTokenFilter@74466729 term=,bytes=[],startOffset=0,endOffset=0,positionIncrement=1,type=word,positionLength=1,keyword=false)
[junit4] 2> org.apache.lucene.analysis.synonym.FlattenGraphFilter(ValidatingTokenFilter@7a23a384 term=,bytes=[],startOffset=0,endOffset=0,positionIncrement=1,type=word,positionLength=1,keyword=false)
[junit4] 2> offsetsAreCorrect=false
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestRandomChains -Dtests.method=testRandomChainsWithLargeStrings -Dtests.seed=30786A43D63AEC6C -Dtests.slow=true -Dtests.locale=el -Dtests.timezone=Pacific/Palau -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] FAILURE 0.47s J1 | TestRandomChains.testRandomChainsWithLargeStrings <<<
[junit4] > Throwable #1: java.lang.AssertionError: pos=6 nextPos=10 count=3
[junit4] > at __randomizedtesting.SeedInfo.seed([30786A43D63AEC6C:5A23D5528F74CC9F]:0)
[junit4] > at org.apache.lucene.util.RollingBuffer.get(RollingBuffer.java:105)
[junit4] > at org.apache.lucene.analysis.synonym.FlattenGraphFilter.releaseBufferedToken(FlattenGraphFilter.java:183)
[junit4] > at org.apache.lucene.analysis.synonym.FlattenGraphFilter.incrementToken(FlattenGraphFilter.java:264)
[junit4] > at org.apache.lucene.analysis.ValidatingTokenFilter.incrementToken(ValidatingTokenFilter.java:67)
[junit4] > at org.apache.lucene.analysis.BaseTokenStreamTestCase.checkAnalysisConsistency(BaseTokenStreamTestCase.java:724)
[junit4] > at org.apache.lucene.analysis.BaseTokenStreamTestCase.checkRandomData(BaseTokenStreamTestCase.java:635)
[junit4] > at org.apache.lucene.analysis.BaseTokenStreamTestCase.checkRandomData(BaseTokenStreamTestCase.java:533)
[junit4] > at org.apache.lucene.analysis.core.TestRandomChains.testRandomChainsWithLargeStrings(TestRandomChains.java:869)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {dummy=PostingsFormat(name=LuceneFixedGap)}, docValues:{}, maxPointsInLeafNode=1328, maxMBSortInHeap=6.613126557066521, sim=RandomSimilarity(queryNorm=true): {}, locale=el, timezone=Pacific/Palau
[junit4] 2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_112 (64-bit)/cpus=3,threads=1,free=240496064,total=314572800
[junit4] 2> NOTE: All tests run in this JVM: [TestClassicAnalyzer, TestLimitTokenCountFilterFactory, TestHunspellStemFilterFactory, EdgeNGramTokenizerTest, TestSwedishLightStemFilterFactory, TestRussianLightStemFilterFactory, TestUAX29URLEmailAnalyzer, TestRandomChains]
[junit4] Completed [14/275 (1!)] on J1 in 3.32s, 2 tests, 1 failure <<< FAILURES!
[...truncated 73009 lines...]
[JENKINS] Lucene-Solr-master-Solaris (64bit/jdk1.8.0) - Build #
1047 - Still Unstable!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Solaris/1047/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseSerialGC
2 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.hdfs.HdfsRecoveryZkTest
Error Message:
ObjectTracker found 1 object(s) that were not released!!! [HdfsTransactionLog] org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:43) at org.apache.solr.update.HdfsTransactionLog.<init>(HdfsTransactionLog.java:130) at org.apache.solr.update.HdfsUpdateLog.init(HdfsUpdateLog.java:202) at org.apache.solr.update.UpdateHandler.<init>(UpdateHandler.java:137) at org.apache.solr.update.UpdateHandler.<init>(UpdateHandler.java:94) at org.apache.solr.update.DirectUpdateHandler2.<init>(DirectUpdateHandler2.java:102) at sun.reflect.GeneratedConstructorAccessor139.newInstance(Unknown Source) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:423) at org.apache.solr.core.SolrCore.createInstance(SolrCore.java:747) at org.apache.solr.core.SolrCore.createUpdateHandler(SolrCore.java:809) at org.apache.solr.core.SolrCore.initUpdateHandler(SolrCore.java:1060) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:925) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:817) at org.apache.solr.core.CoreContainer.create(CoreContainer.java:906) at org.apache.solr.core.CoreContainer.lambda$load$3(CoreContainer.java:551) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745)
Stack Trace:
java.lang.AssertionError: ObjectTracker found 1 object(s) that were not released!!! [HdfsTransactionLog]
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException
at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:43)
at org.apache.solr.update.HdfsTransactionLog.<init>(HdfsTransactionLog.java:130)
at org.apache.solr.update.HdfsUpdateLog.init(HdfsUpdateLog.java:202)
at org.apache.solr.update.UpdateHandler.<init>(UpdateHandler.java:137)
at org.apache.solr.update.UpdateHandler.<init>(UpdateHandler.java:94)
at org.apache.solr.update.DirectUpdateHandler2.<init>(DirectUpdateHandler2.java:102)
at sun.reflect.GeneratedConstructorAccessor139.newInstance(Unknown Source)
at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45)
at java.lang.reflect.Constructor.newInstance(Constructor.java:423)
at org.apache.solr.core.SolrCore.createInstance(SolrCore.java:747)
at org.apache.solr.core.SolrCore.createUpdateHandler(SolrCore.java:809)
at org.apache.solr.core.SolrCore.initUpdateHandler(SolrCore.java:1060)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:925)
at org.apache.solr.core.SolrCore.<init>(SolrCore.java:817)
at org.apache.solr.core.CoreContainer.create(CoreContainer.java:906)
at org.apache.solr.core.CoreContainer.lambda$load$3(CoreContainer.java:551)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
at __randomizedtesting.SeedInfo.seed([E3B52153CC2CEEE2]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertNull(Assert.java:551)
at org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:266)
at sun.reflect.GeneratedMethodAccessor28.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:870)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
FAILED: org.apache.solr.update.AutoCommitTest.testCommitWithin
Error Message:
Exception during query
Stack Trace:
java.lang.RuntimeException: Exception during query
at __randomizedtesting.SeedInfo.seed([E3B52153CC2CEEE2:59674E2B4F0200F7]:0)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:818)
at org.apache.solr.update.AutoCommitTest.testCommitWithin(AutoCommitTest.java:353)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//result[@numFound=1]
xml response was: <?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader"><int name="status">0</int><int name="QTime">0</int></lst><result name="response" numFound="0" start="0"></result>
</response>
request was:q=id:529&qt=standard&start=0&rows=20&version=2.2
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:811)
... 40 more
Build Log:
[...truncated 11761 lines...]
[junit4] Suite: org.apache.solr.update.AutoCommitTest
[junit4] 2> Creating dataDir: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_E3B52153CC2CEEE2-001/init-core-data-001
[junit4] 2> 1507250 INFO (SUITE-AutoCommitTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 1507250 INFO (SUITE-AutoCommitTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 1507251 INFO (SUITE-AutoCommitTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1507287 INFO (SUITE-AutoCommitTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1507313 INFO (SUITE-AutoCommitTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 1507432 WARN (SUITE-AutoCommitTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.a.s.s.IndexSchema [null] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 1507435 INFO (SUITE-AutoCommitTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1507453 WARN (SUITE-AutoCommitTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer.
[junit4] 2> 1507457 INFO (SUITE-AutoCommitTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@299d5ce0
[junit4] 2> 1507458 WARN (SUITE-AutoCommitTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer.
[junit4] 2> 1507464 INFO (SUITE-AutoCommitTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@299d5ce0
[junit4] 2> 1507464 WARN (SUITE-AutoCommitTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer.
[junit4] 2> 1507464 INFO (SUITE-AutoCommitTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@299d5ce0
[junit4] 2> 1507464 WARN (SUITE-AutoCommitTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer.
[junit4] 2> 1507464 INFO (SUITE-AutoCommitTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@299d5ce0
[junit4] 2> 1507466 INFO (coreLoadExecutor-5661-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1507509 INFO (coreLoadExecutor-5661-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1507529 INFO (coreLoadExecutor-5661-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1507643 WARN (coreLoadExecutor-5661-thread-1) [ 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> 1507645 INFO (coreLoadExecutor-5661-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1507652 INFO (coreLoadExecutor-5661-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1
[junit4] 2> 1507652 INFO (coreLoadExecutor-5661-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_E3B52153CC2CEEE2-001/init-core-data-001/]
[junit4] 2> 1507653 WARN (coreLoadExecutor-5661-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer.
[junit4] 2> 1507653 INFO (coreLoadExecutor-5661-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@299d5ce0
[junit4] 2> 1507653 INFO (coreLoadExecutor-5661-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@299d5ce0
[junit4] 2> 1507654 INFO (coreLoadExecutor-5661-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1225865721, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1507693 INFO (coreLoadExecutor-5661-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1507694 INFO (coreLoadExecutor-5661-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1507695 INFO (coreLoadExecutor-5661-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1507695 INFO (coreLoadExecutor-5661-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1507695 INFO (coreLoadExecutor-5661-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=19, maxMergeAtOnceExplicit=12, maxMergedSegmentMB=91.986328125, floorSegmentMB=1.4013671875, forceMergeDeletesPctAllowed=29.6784936963833, segmentsPerTier=44.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 1507696 INFO (coreLoadExecutor-5661-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@7ed28667[collection1] main]
[junit4] 2> 1507697 INFO (coreLoadExecutor-5661-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1508137 INFO (coreLoadExecutor-5661-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1508189 INFO (coreLoadExecutor-5661-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1508189 INFO (searcherExecutor-5662-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1508190 INFO (searcherExecutor-5662-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1508190 INFO (searcherExecutor-5662-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1508190 INFO (searcherExecutor-5662-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 1508190 INFO (searcherExecutor-5662-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1508191 INFO (searcherExecutor-5662-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1508192 INFO (coreLoadExecutor-5661-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1555288412173369344
[junit4] 2> 1508192 INFO (searcherExecutor-5662-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1508192 INFO (searcherExecutor-5662-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1508193 INFO (searcherExecutor-5662-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1508193 INFO (searcherExecutor-5662-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7ed28667[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1508196 INFO (SUITE-AutoCommitTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 1508200 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testMaxTime
[junit4] 2> 1508202 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:* (-1555288412181757952)} 0 1
[junit4] 2> 1508204 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1508244 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1508293 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1508405 WARN (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ ] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 1508407 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1508414 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ ] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1
[junit4] 2> 1508415 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_E3B52153CC2CEEE2-001/init-core-data-001/]
[junit4] 2> 1508415 WARN (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer.
[junit4] 2> 1508422 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@299d5ce0
[junit4] 2> 1508423 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.m.SolrMetricManager Replacing existing reporter 'default' in registry 'solr.core.collection1': [org.apache.solr.metrics.reporters.SolrJmxReporter@7b7dac55: domain = solr.core.collection1, service url = null, agent id = null]
[junit4] 2> 1508427 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@299d5ce0
[junit4] 2> 1508448 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1508448 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1508448 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@27e31a26[collection1] main]
[junit4] 2> 1508448 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1508449 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1508452 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1508454 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=24, maxMergeAtOnceExplicit=36, maxMergedSegmentMB=45.638671875, floorSegmentMB=1.353515625, forceMergeDeletesPctAllowed=0.2875045152300548, segmentsPerTier=17.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.2586174436932398
[junit4] 2> 1508455 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1508455 INFO (searcherExecutor-5667-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1508456 INFO (searcherExecutor-5667-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1508456 INFO (searcherExecutor-5667-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1508456 INFO (searcherExecutor-5667-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 1508456 INFO (searcherExecutor-5667-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1508456 INFO (searcherExecutor-5667-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1508457 INFO (searcherExecutor-5667-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1508457 INFO (searcherExecutor-5667-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1508457 INFO (searcherExecutor-5667-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1508458 INFO (searcherExecutor-5667-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@27e31a26[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1508458 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@366f67c8[collection1] main]
[junit4] 2> 1508458 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@ae8501d
[junit4] 2> 1508459 INFO (searcherExecutor-5667-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@366f67c8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1508464 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
[junit4] 2> 1508472 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 (1555288412464873472)]} 0 2
[junit4] 2> 1508472 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 1509972 INFO (commitScheduler-5670-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> 1509978 INFO (commitScheduler-5670-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@23db41c8[collection1] main]
[junit4] 2> 1509978 INFO (commitScheduler-5670-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1509979 INFO (searcherExecutor-5667-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@23db41c8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c1)))}
[junit4] 2> 1510227 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 (1555288414306172928)]} 0 1758
[junit4] 2> 1510227 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
[junit4] 2> 1510228 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 1510229 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{delete=[529 (-1555288414309318656)]} 0 0
[junit4] 2> 1510229 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
[junit4] 2> 1511727 INFO (commitScheduler-5670-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> 1511730 INFO (commitScheduler-5670-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@25ad0cf[collection1] main]
[junit4] 2> 1511730 INFO (commitScheduler-5670-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1511732 INFO (searcherExecutor-5667-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@25ad0cf[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.0.0):c1)))}
[junit4] 2> 1511736 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[550 (1555288415889522688)]} 0 3268
[junit4] 2> 1511737 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 1511737 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1555288415890571264)]} 0 3269
[junit4] 2> 1511737 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1555288415890571265)]} 0 3269
[junit4] 2> 1511738 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1555288415891619840)]} 0 3269
[junit4] 2> 1511738 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1555288415891619841)]} 0 3269
[junit4] 2> 1511738 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1555288415891619842)]} 0 3270
[junit4] 2> 1511738 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1555288415891619843)]} 0 3270
[junit4] 2> 1511738 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1555288415891619844)]} 0 3270
[junit4] 2> 1511739 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1555288415892668416)]} 0 3270
[junit4] 2> 1511739 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1555288415892668417)]} 0 3270
[junit4] 2> 1511739 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1555288415892668418)]} 0 3271
[junit4] 2> 1511739 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:500&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 1513237 INFO (commitScheduler-5670-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> 1513241 INFO (commitScheduler-5670-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@586048ba[collection1] main]
[junit4] 2> 1513241 INFO (commitScheduler-5670-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1513243 INFO (searcherExecutor-5667-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@586048ba[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.0.0):c1) Uninverting(_2(7.0.0):c11/9:delGen=1)))}
[junit4] 2> 1513243 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[531 (1555288417469726720)]} 0 4776
[junit4] 2> 1513244 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:500&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
[junit4] 2> 1513244 INFO (TEST-AutoCommitTest.testMaxTime-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testMaxTime
[junit4] 2> 1513249 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.SolrTestCaseJ4 ###Starting testMaxDocs
[junit4] 2> 1513253 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3ff4a2de[collection1] realtime]
[junit4] 2> 1513253 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:* (-1555288417476018176)} 0 4
[junit4] 2> 1513254 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1513288 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1513309 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1513411 WARN (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ 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> 1513413 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1513423 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1
[junit4] 2> 1513424 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_E3B52153CC2CEEE2-001/init-core-data-001/]
[junit4] 2> 1513424 WARN (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer.
[junit4] 2> 1513433 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@299d5ce0
[junit4] 2> 1513433 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@299d5ce0
[junit4] 2> 1513460 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1513460 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1513461 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5f4be4a0[collection1] main]
[junit4] 2> 1513461 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1513464 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1513468 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1513469 INFO (searcherExecutor-5671-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1513469 INFO (searcherExecutor-5671-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1513469 INFO (searcherExecutor-5671-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1513469 INFO (searcherExecutor-5671-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 1513470 INFO (searcherExecutor-5671-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1513470 INFO (searcherExecutor-5671-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1513471 INFO (searcherExecutor-5671-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1513472 INFO (searcherExecutor-5671-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1513472 INFO (searcherExecutor-5671-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1513473 INFO (searcherExecutor-5671-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5f4be4a0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1513479 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=25, maxMergeAtOnceExplicit=10, maxMergedSegmentMB=17.9853515625, floorSegmentMB=2.125, forceMergeDeletesPctAllowed=3.6062889853270272, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 1513479 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1513479 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@12d2ec37[collection1] main]
[junit4] 2> 1513480 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@617a6dfa
[junit4] 2> 1513481 INFO (searcherExecutor-5671-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@12d2ec37[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1513489 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
[junit4] 2> 1513494 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 (1555288417731870720)]} 0 1
[junit4] 2> 1513494 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[1 (1555288417732919296)]} 0 1
[junit4] 2> 1513494 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[2 (1555288417732919297)]} 0 1
[junit4] 2> 1513495 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3 (1555288417733967872)]} 0 1
[junit4] 2> 1513495 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[4 (1555288417733967873)]} 0 1
[junit4] 2> 1513495 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[5 (1555288417733967874)]} 0 2
[junit4] 2> 1513495 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6 (1555288417733967875)]} 0 2
[junit4] 2> 1513495 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[7 (1555288417733967876)]} 0 2
[junit4] 2> 1513495 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[8 (1555288417733967877)]} 0 2
[junit4] 2> 1513496 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9 (1555288417733967878)]} 0 2
[junit4] 2> 1513496 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[10 (1555288417735016448)]} 0 2
[junit4] 2> 1513496 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[11 (1555288417735016449)]} 0 2
[junit4] 2> 1513496 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12 (1555288417735016450)]} 0 3
[junit4] 2> 1513496 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[13 (1555288417735016451)]} 0 3
[junit4] 2> 1513496 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:1&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 1513497 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[14 (1555288417736065024)]} 0 3
[junit4] 2> 1513498 INFO (commitScheduler-5674-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> 1513507 INFO (commitScheduler-5674-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@12431c49[collection1] main]
[junit4] 2> 1513507 INFO (commitScheduler-5674-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1513508 INFO (searcherExecutor-5671-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@12431c49[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.0.0):c15)))}
[junit4] 2> 1513749 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15 (1555288417999257600)]} 0 255
[junit4] 2> 1513749 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:14&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
[junit4] 2> 1513749 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:15&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 1513749 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testMaxDocs
[junit4] 2> 1513754 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.SolrTestCaseJ4 ###Starting testCommitWithin
[junit4] 2> 1513760 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@209ef354[collection1] realtime]
[junit4] 2> 1513760 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{deleteByQuery=*:* (-1555288418005549056)} 0 6
[junit4] 2> 1513761 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1513806 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1513861 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1513962 WARN (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ 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> 1513964 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1513972 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1
[junit4] 2> 1513972 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_E3B52153CC2CEEE2-001/init-core-data-001/]
[junit4] 2> 1513972 WARN (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer.
[junit4] 2> 1513980 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@299d5ce0
[junit4] 2> 1513980 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@299d5ce0
[junit4] 2> 1514004 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1514005 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1514005 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@90f0e6b[collection1] main]
[junit4] 2> 1514005 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1514006 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1514009 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1514013 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=20, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=11.5966796875, floorSegmentMB=2.1923828125, forceMergeDeletesPctAllowed=29.084769565545418, segmentsPerTier=11.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 1514013 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1514013 INFO (searcherExecutor-5675-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1514013 INFO (searcherExecutor-5675-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1514014 INFO (searcherExecutor-5675-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1514014 INFO (searcherExecutor-5675-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 1514014 INFO (searcherExecutor-5675-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1514014 INFO (searcherExecutor-5675-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1514014 INFO (searcherExecutor-5675-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1514015 INFO (searcherExecutor-5675-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1514015 INFO (searcherExecutor-5675-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1514016 INFO (searcherExecutor-5675-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@90f0e6b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1514016 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@690f3e84[collection1] main]
[junit4] 2> 1514017 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@5530d082
[junit4] 2> 1514023 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
[junit4] 2> 1514028 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 (1555288418291810304)]} 0 1
[junit4] 2> 1514028 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 1514029 INFO (searcherExecutor-5675-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@690f3e84[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1514280 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 (1555288418556051456)]} 0 253
[junit4] 2> 1514280 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 1514281 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[529 (-1555288418558148608)]} 0 254
[junit4] 2> 1514281 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 1514281 ERROR (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.SolrTestCaseJ4 REQUEST FAILED: xpath=//result[@numFound=1]
[junit4] 2> xml response was: <?xml version="1.0" encoding="UTF-8"?>
[junit4] 2> <response>
[junit4] 2> <lst name="responseHeader"><int name="status">0</int><int name="QTime">0</int></lst><result name="response" numFound="0" start="0"></result>
[junit4] 2> </response>
[junit4] 2>
[junit4] 2> request was:q=id:529&qt=standard&start=0&rows=20&version=2.2
[junit4] 2> 1514282 ERROR (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.SolrTestCaseJ4 REQUEST FAILED: q=id:529&qt=standard&start=0&rows=20&version=2.2:java.lang.RuntimeException: REQUEST FAILED: xpath=//result[@numFound=1]
[junit4] 2> xml response was: <?xml version="1.0" encoding="UTF-8"?>
[junit4] 2> <response>
[junit4] 2> <lst name="responseHeader"><int name="status">0</int><int name="QTime">0</int></lst><result name="response" numFound="0" start="0"></result>
[junit4] 2> </response>
[junit4] 2>
[junit4] 2> request was:q=id:529&qt=standard&start=0&rows=20&version=2.2
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:811)
[junit4] 2> at org.apache.solr.update.AutoCommitTest.testCommitWithin(AutoCommitTest.java:353)
[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:1713)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[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:811)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 1514282 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[E3B52153CC2CEEE2]) [ x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testCommitWithin
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=AutoCommitTest -Dtests.method=testCommitWithin -Dtests.seed=E3B52153CC2CEEE2 -Dtests.slow=true -Dtests.locale=sr-Latn -Dtests.timezone=AST -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.54s J1 | AutoCommitTest.testCommitWithin <<<
[junit4] > Throwable #1: java.lang.RuntimeException: Exception during query
[junit4] > at __randomizedtesting.SeedInfo.seed([E3B52153CC2CEEE2:59674E2B4F0200F7]:0)
[junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:818)
[junit4] > at org.apache.solr.update.AutoCommitTest.testCommitWithin(AutoCommitTest.java:353)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//result[@numFound=1]
[junit4] > xml response was: <?xml version="1.0" encoding="UTF-8"?>
[junit4] > <response>
[junit4] > <lst name="responseHeader"><int name="status">0</int><int name="QTime">0</int></lst><result name="response" numFound="0" start="0"></result>
[junit4] > </response>
[junit4] > request was:q=id:529&qt=standard&start=0&rows=20&version=2.2
[junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:811)
[junit4] > ... 40 more
[junit4] 2> 1514285 INFO (SUITE-AutoCommitTest-seed#[E3B52153CC2CEEE2]-worker) [ x:collection1] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 1514286 INFO (SUITE-AutoCommitTest-seed#[E3B52153CC2CEEE2]-worker) [ x:collection1] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1847411601
[junit4] 2> 1514286 INFO (coreCloseExecutor-5679-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1527d8cf
[junit4] 2> 1514287 INFO (coreCloseExecutor-5679-thread-1-processing-x:collection1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
[junit4] 2> 1514287 INFO (coreCloseExecutor-5679-thread-1-processing-x:collection1) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@59e438ec
[junit4] 2> 1514306 INFO (coreCloseExecutor-5679-thread-1-processing-x:collection1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
[junit4] 2> 1514307 INFO (SUITE-AutoCommitTest-seed#[E3B52153CC2CEEE2]-worker) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> NOTE: leaving temporary files on disk at: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_E3B52153CC2CEEE2-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {range_facet_l_dv=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), _version_=PostingsFormat(name=Asserting), field_t=PostingsFormat(name=Direct), multiDefault=PostingsFormat(name=MockRandom), subject=PostingsFormat(name=MockRandom), intDefault=PostingsFormat(name=Asserting), id=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), range_facet_i_dv=PostingsFormat(name=Asserting), text=PostingsFormat(name=Direct), range_facet_l=PostingsFormat(name=Asserting), timestamp=PostingsFormat(name=Asserting)}, docValues:{range_facet_l_dv=DocValuesFormat(name=Direct), range_facet_i_dv=DocValuesFormat(name=Lucene70), timestamp=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=1466, maxMBSortInHeap=7.179972059290144, sim=RandomSimilarity(queryNorm=false): {}, locale=sr-Latn, timezone=AST
[junit4] 2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_112 (64-bit)/cpus=3,threads=1,free=167676376,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [TestJmxMonitoredMap, QueryResultKeyTest, BlockJoinFacetSimpleTest, TestDocTermOrds, SolrCloudExampleTest, TestManagedResource, TestLRUStatsCache, BlockDirectoryTest, TestRebalanceLeaders, TestOmitPositions, TestCorePropertiesReload, HighlighterConfigTest, OverseerModifyCollectionTest, TestIndexSearcher, UUIDFieldTest, CleanupOldIndexTest, TestCloudInspectUtil, DistributedVersionInfoTest, BadComponentTest, TestMinMaxOnMultiValuedField, TestSubQueryTransformerCrossCore, TestCloudPseudoReturnFields, TestInitQParser, TestDefaultSearchFieldResource, ZkStateReaderTest, CircularListTest, ZkSolrClientTest, TestZkChroot, JSONWriterTest, TestSSLRandomization, TestSearcherReuse, TestRangeQuery, DistanceFunctionTest, TestFileDictionaryLookup, RemoteQueryErrorTest, TestMacroExpander, MultiThreadedOCPTest, CoreAdminRequestStatusTest, TestAuthenticationFramework, ClassificationUpdateProcessorIntegrationTest, TestRecoveryHdfs, TestSolrIndexConfig, TestComponentsName, TestDistributedGrouping, TestDeleteCollectionOnDownNodes, TestSolrQueryParserDefaultOperatorResource, InfoHandlerTest, UUIDUpdateProcessorFallbackTest, TestFieldCacheSort, FieldMutatingUpdateProcessorTest, TestConfigReload, TestIndexingPerformance, TestCollationFieldDocValues, TestDocSet, CollectionReloadTest, TestBadConfig, TestFieldTypeResource, TestSolrQueryParser, SparseHLLTest, TestJoin, TestPushWriter, ResponseLogComponentTest, TestSolrCoreProperties, SolrJmxReporterTest, TestAtomicUpdateErrorCases, TestRuleBasedAuthorizationPlugin, CollectionTooManyReplicasTest, HdfsDirectoryTest, TestRestManager, SortSpecParsingTest, MergeStrategyTest, ReplicationFactorTest, TestSmileRequest, TestSchemaVersionResource, TestPerFieldSimilarityWithDefaultOverride, TriLevelCompositeIdRoutingTest, SpellCheckCollatorTest, TestFieldResource, HdfsThreadLeakTest, SharedFSAutoReplicaFailoverTest, DeleteInactiveReplicaTest, TestAuthorizationFramework, HdfsChaosMonkeyNothingIsSafeTest, CloneFieldUpdateProcessorFactoryTest, LeaderFailureAfterFreshStartTest, ScriptEngineTest, CdcrVersionReplicationTest, SuggesterTSTTest, AtomicUpdatesTest, RollingRestartTest, TestFoldingMultitermQuery, TestSuggestSpellingConverter, PreAnalyzedFieldTest, CoreAdminHandlerTest, TestSolrCloudWithSecureImpersonation, SimpleMLTQParserTest, TestDefaultStatsCache, PeerSyncWithIndexFingerprintCachingTest, TestLMDirichletSimilarityFactory, URLClassifyProcessorTest, EchoParamsTest, BigEndianAscendingWordSerializerTest, TestAnalyzeInfixSuggestions, TestRestoreCore, TestRawTransformer, DirectUpdateHandlerOptimizeTest, SignatureUpdateProcessorFactoryTest, ConfigSetsAPITest, FileBasedSpellCheckerTest, TestSolrDeletionPolicy2, OverseerStatusTest, TestQueryUtils, AddBlockUpdateTest, TestHdfsCloudBackupRestore, TestUtils, TestSolr4Spatial, SolrIndexSplitterTest, TestLeaderElectionZkExpiry, RequestHandlersTest, ShowFileRequestHandlerTest, SecurityConfHandlerTest, TestDynamicFieldResource, TestFieldSortValues, RAMDirectoryFactoryTest, TestGraphTermsQParserPlugin, TestConfigSetsAPI, DistributedQueryComponentOptimizationTest, HdfsCollectionsAPIDistributedZkTest, UpdateParamsTest, TestUseDocValuesAsStored2, SuggesterTest, JsonLoaderTest, TestFieldCacheReopen, CoreSorterTest, UpdateRequestProcessorFactoryTest, TestRandomFaceting, NotRequiredUniqueKeyTest, SimpleCollectionCreateDeleteTest, TestFuzzyAnalyzedSuggestions, TestRequestForwarding, BlockJoinFacetDistribTest, TestUniqueKeyFieldResource, DistributedFacetPivotLargeTest, TestClusterProperties, DateRangeFieldTest, SpellingQueryConverterTest, TestQueryWrapperFilter, TestManagedSchemaAPI, PreAnalyzedFieldManagedSchemaCloudTest, SuggesterWFSTTest, EnumFieldTest, FieldAnalysisRequestHandlerTest, TestCodecSupport, TestReversedWildcardFilterFactory, TestStressRecovery, TestWriterPerf, TestSolrDynamicMBean, TestRecovery, TestSolrCLIRunExample, DeleteNodeTest, TestHighFrequencyDictionaryFactory, TestSortByMinMaxFunction, ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test, UnloadDistributedZkTest, CollectionsAPIDistributedZkTest, SyncSliceTest, LeaderElectionIntegrationTest, ShardRoutingTest, RecoveryZkTest, ClusterStateUpdateTest, LeaderElectionTest, AutoCommitTest]
[junit4] Completed [354/673 (1!)] on J1 in 7.08s, 3 tests, 1 error <<< FAILURES!
[...truncated 555 lines...]
[junit4] Suite: org.apache.solr.cloud.hdfs.HdfsRecoveryZkTest
[junit4] 2> Creating dataDir: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsRecoveryZkTest_E3B52153CC2CEEE2-001/init-core-data-001
[junit4] 2> 2267704 INFO (SUITE-HdfsRecoveryZkTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 2267706 INFO (SUITE-HdfsRecoveryZkTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsRecoveryZkTest_E3B52153CC2CEEE2-001/tempDir-001
[junit4] 2> 2267707 INFO (SUITE-HdfsRecoveryZkTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2267707 INFO (Thread-7638) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2267707 INFO (Thread-7638) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 2267807 INFO (SUITE-HdfsRecoveryZkTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:55838
[junit4] 2> 2267819 INFO (jetty-launcher-4437-thread-2) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 2267819 INFO (jetty-launcher-4437-thread-1) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 2267822 INFO (jetty-launcher-4437-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6b6e910c{/solr,null,AVAILABLE}
[junit4] 2> 2267822 INFO (jetty-launcher-4437-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@288a3a63{/solr,null,AVAILABLE}
[junit4] 2> 2267823 INFO (jetty-launcher-4437-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@24c3795b{SSL,[ssl, http/1.1]}{127.0.0.1:43737}
[junit4] 2> 2267823 INFO (jetty-launcher-4437-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@656eb2ad{SSL,[ssl, http/1.1]}{127.0.0.1:56506}
[junit4] 2> 2267823 INFO (jetty-launcher-4437-thread-1) [ ] o.e.j.s.Server Started @2272182ms
[junit4] 2> 2267823 INFO (jetty-launcher-4437-thread-2) [ ] o.e.j.s.Server Started @2272182ms
[junit4] 2> 2267823 INFO (jetty-launcher-4437-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=43737}
[junit4] 2> 2267823 INFO (jetty-launcher-4437-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=56506}
[junit4] 2> 2267823 ERROR (jetty-launcher-4437-thread-2) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2267824 INFO (jetty-launcher-4437-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.0.0
[junit4] 2> 2267824 INFO (jetty-launcher-4437-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2267824 INFO (jetty-launcher-4437-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2267823 ERROR (jetty-launcher-4437-thread-1) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2267824 INFO (jetty-launcher-4437-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.0.0
[junit4] 2> 2267824 INFO (jetty-launcher-4437-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2267824 INFO (jetty-launcher-4437-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2267824 INFO (jetty-launcher-4437-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-01-01T02:56:13.470Z
[junit4] 2> 2267824 INFO (jetty-launcher-4437-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-01-01T02:56:13.470Z
[junit4] 2> 2267829 INFO (jetty-launcher-4437-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2267829 INFO (jetty-launcher-4437-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2267838 INFO (jetty-launcher-4437-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:55838/solr
[junit4] 2> 2267838 INFO (jetty-launcher-4437-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:55838/solr
[junit4] 2> 2267887 INFO (jetty-launcher-4437-thread-2) [n:127.0.0.1:56506_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:56506_solr
[junit4] 2> 2267888 INFO (jetty-launcher-4437-thread-1) [n:127.0.0.1:43737_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:43737_solr
[junit4] 2> 2267890 INFO (jetty-launcher-4437-thread-2) [n:127.0.0.1:56506_solr ] o.a.s.c.Overseer Overseer (id=97205575572193285-127.0.0.1:56506_solr-n_0000000000) starting
[junit4] 2> 2267891 INFO (zkCallback-4448-thread-1-processing-n:127.0.0.1:43737_solr) [n:127.0.0.1:43737_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2267892 INFO (zkCallback-4447-thread-1-processing-n:127.0.0.1:56506_solr) [n:127.0.0.1:56506_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2267910 INFO (jetty-launcher-4437-thread-2) [n:127.0.0.1:56506_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:56506_solr
[junit4] 2> 2267913 INFO (zkCallback-4448-thread-1-processing-n:127.0.0.1:43737_solr) [n:127.0.0.1:43737_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2267913 INFO (zkCallback-4447-thread-1-processing-n:127.0.0.1:56506_solr) [n:127.0.0.1:56506_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2267948 INFO (jetty-launcher-4437-thread-1) [n:127.0.0.1:43737_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsRecoveryZkTest_E3B52153CC2CEEE2-001/tempDir-001/node1/.
[junit4] 2> 2268186 INFO (jetty-launcher-4437-thread-2) [n:127.0.0.1:56506_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsRecoveryZkTest_E3B52153CC2CEEE2-001/tempDir-001/node2/.
[junit4] 2> 2268940 INFO (SUITE-HdfsRecoveryZkTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 2268942 INFO (SUITE-HdfsRecoveryZkTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:55838/solr ready
[junit4] 1> Formatting using clusterid: testClusterID
[junit4] 2> 2269032 WARN (SUITE-HdfsRecoveryZkTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.a.h.m.i.MetricsConfig Cannot locate configuration: tried hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
[junit4] 2> 2269042 WARN (SUITE-HdfsRecoveryZkTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 2269044 INFO (SUITE-HdfsRecoveryZkTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.m.log jetty-6.1.26
[junit4] 2> 2269059 INFO (SUITE-HdfsRecoveryZkTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.m.log Extract jar:file:/export/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.2-tests.jar!/webapps/hdfs to ./temp/Jetty_solaris.vm_45738_hdfs____ly3xal/webapp
[junit4] 2> 2269608 INFO (SUITE-HdfsRecoveryZkTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@solaris-vm:45738
[junit4] 2> 2269744 WARN (SUITE-HdfsRecoveryZkTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 2269747 INFO (SUITE-HdfsRecoveryZkTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.m.log jetty-6.1.26
[junit4] 2> 2269763 INFO (SUITE-HdfsRecoveryZkTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.m.log Extract jar:file:/export/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.2-tests.jar!/webapps/datanode to ./temp/Jetty_localhost_34145_datanode____.4r9ulk/webapp
[junit4] 2> 2270332 INFO (SUITE-HdfsRecoveryZkTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:34145
[junit4] 2> 2270421 WARN (SUITE-HdfsRecoveryZkTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 2270422 INFO (SUITE-HdfsRecoveryZkTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.m.log jetty-6.1.26
[junit4] 2> 2270440 INFO (SUITE-HdfsRecoveryZkTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.m.log Extract jar:file:/export/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.2-tests.jar!/webapps/datanode to ./temp/Jetty_localhost_59695_datanode____9m2pat/webapp
[junit4] 2> 2270512 INFO (IPC Server handler 3 on 44615) [ ] BlockStateChange BLOCK* processReport: from storage DS-9d65aee8-7d9b-4834-a7f0-5359a07910bc node DatanodeRegistration(127.0.0.1:41658, datanodeUuid=e1d088f4-f222-4006-b0c5-f0103171c9f0, infoPort=52271, infoSecurePort=0, ipcPort=65067, storageInfo=lv=-56;cid=testClusterID;nsid=1275677366;c=0), blocks: 0, hasStaleStorage: true, processing time: 0 msecs
[junit4] 2> 2270512 INFO (IPC Server handler 3 on 44615) [ ] BlockStateChange BLOCK* processReport: from storage DS-835fed7e-ba36-45d0-a883-63dc960c19f9 node DatanodeRegistration(127.0.0.1:41658, datanodeUuid=e1d088f4-f222-4006-b0c5-f0103171c9f0, infoPort=52271, infoSecurePort=0, ipcPort=65067, storageInfo=lv=-56;cid=testClusterID;nsid=1275677366;c=0), blocks: 0, hasStaleStorage: false, processing time: 0 msecs
[junit4] 2> 2270996 INFO (SUITE-HdfsRecoveryZkTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:59695
[junit4] 2> 2271143 INFO (IPC Server handler 5 on 44615) [ ] BlockStateChange BLOCK* processReport: from storage DS-b6c14c5f-7e80-4690-8dec-24cebe84e213 node DatanodeRegistration(127.0.0.1:42772, datanodeUuid=da62bbb2-edb6-41fd-b56f-3b359ec4d185, infoPort=39317, infoSecurePort=0, ipcPort=45943, storageInfo=lv=-56;cid=testClusterID;nsid=1275677366;c=0), blocks: 0, hasStaleStorage: true, processing time: 0 msecs
[junit4] 2> 2271143 INFO (IPC Server handler 5 on 44615) [ ] BlockStateChange BLOCK* processReport: from storage DS-edcfa73e-6e0c-446a-9149-4769cc537f9a node DatanodeRegistration(127.0.0.1:42772, datanodeUuid=da62bbb2-edb6-41fd-b56f-3b359ec4d185, infoPort=39317, infoSecurePort=0, ipcPort=45943, storageInfo=lv=-56;cid=testClusterID;nsid=1275677366;c=0), blocks: 0, hasStaleStorage: false, processing time: 0 msecs
[junit4] 2> 2271236 INFO (TEST-HdfsRecoveryZkTest.test-seed#[E3B52153CC2CEEE2]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 2271259 INFO (qtp2058383248-27080) [n:127.0.0.1:43737_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=2&collection.configName=conf&maxShardsPerNode=1&name=recoverytest&action=CREATE&numShards=1&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 2271262 INFO (OverseerThreadFactory-10097-thread-1-processing-n:127.0.0.1:56506_solr) [n:127.0.0.1:56506_solr ] o.a.s.c.CreateCollectionCmd Create collection recoverytest
[junit4] 2> 2271385 INFO (qtp2058383248-27081) [n:127.0.0.1:43737_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=recoverytest_shard1_replica1&action=CREATE&numShards=1&collection=recoverytest&shard=shard1&wt=javabin&version=2
[junit4] 2> 2271399 INFO (qtp2038592928-27091) [n:127.0.0.1:56506_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf&newCollection=true&name=recoverytest_shard1_replica2&action=CREATE&numShards=1&collection=recoverytest&shard=shard1&wt=javabin&version=2
[junit4] 2> 2271506 INFO (zkCallback-4448-thread-1-processing-n:127.0.0.1:43737_solr) [n:127.0.0.1:43737_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/recoverytest/state.json] for collection [recoverytest] has occurred - updating... (live nodes size: [2])
[junit4] 2> 2271506 INFO (zkCallback-4447-thread-3-processing-n:127.0.0.1:56506_solr) [n:127.0.0.1:56506_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/recoverytest/state.json] for collection [recoverytest] has occurred - updating... (live nodes size: [2])
[junit4] 2> 2272404 INFO (qtp2058383248-27081) [n:127.0.0.1:43737_solr c:recoverytest s:shard1 x:recoverytest_shard1_replica1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 2272413 INFO (qtp2058383248-27081) [n:127.0.0.1:43737_solr c:recoverytest s:shard1 x:recoverytest_shard1_replica1] o.a.s.s.IndexSchema [recoverytest_shard1_replica1] Schema name=minimal
[junit4] 2> 2272413 INFO (qtp2038592928-27091) [n:127.0.0.1:56506_solr c:recoverytest s:shard1 x:recoverytest_shard1_replica2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 2272416 INFO (qtp2058383248-27081) [n:127.0.0.1:43737_solr c:recoverytest s:shard1 x:recoverytest_shard1_replica1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 2272418 INFO (qtp2058383248-27081) [n:127.0.0.1:43737_solr c:recoverytest s:shard1 x:recoverytest_shard1_replica1] o.a.s.c.CoreContainer Creating SolrCore 'recoverytest_shard1_replica1' using configuration from collection recoverytest
[junit4] 2> 2272420 INFO (qtp2038592928-27091) [n:127.0.0.1:56506_solr c:recoverytest s:shard1 x:recoverytest_shard1_replica2] o.a.s.s.IndexSchema [recoverytest_shard1_replica2] Schema name=minimal
[junit4] 2> 2272422 INFO (qtp2038592928-27091) [n:127.0.0.1:56506_solr c:recoverytest s:shard1 x:recoverytest_shard1_replica2] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 2272423 INFO (qtp2038592928-27091) [n:127.0.0.1:56506_solr c:recoverytest s:shard1 x:recoverytest_shard1_replica2] o.a.s.c.CoreContainer Creating SolrCore 'recoverytest_shard1_replica2' using configuration from collection recoverytest
[junit4] 2> 2272426 INFO (qtp2058383248-27081) [n:127.0.0.1:43737_solr c:recoverytest s:shard1 x:recoverytest_shard1_replica1] o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://solaris-vm:44615/data
[junit4] 2> 2272426 INFO (qtp2058383248-27081) [n:127.0.0.1:43737_solr c:recoverytest s:shard1 x:recoverytest_shard1_replica1] o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 2272426 INFO (qtp2058383248-27081) [n:127.0.0.1:43737_solr c:recoverytest s:shard1 x:recoverytest_shard1_replica1] o.a.s.c.SolrCore [[recoverytest_shard1_replica1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsRecoveryZkTest_E3B52153CC2CEEE2-001/tempDir-001/node1/recoverytest_shard1_replica1], dataDir=[hdfs://solaris-vm:44615/data/recoverytest/core_node1/data/]
[junit4] 2> 2272426 INFO (qtp2058383248-27081) [n:127.0.0.1:43737_solr c:recoverytest s:shard1 x:recoverytest_shard1_replica1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://solaris-vm:44615/data/recoverytest/core_node1/data/snapshot_metadata
[junit4] 2> 2272427 INFO (qtp2038592928-27091) [n:127.0.0.1:56506_solr c:recoverytest s:shard1 x:recoverytest_shard1_replica2] o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://solaris-vm:44615/data
[junit4] 2> 2272427 INFO (qtp2038592928-27091) [n:127.0.0.1:56506_solr c:recoverytest s:shard1 x:recoverytest_shard1_replica2] o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 2272427 INFO (qtp2038592928-27091) [n:127.0.0.1:56506_solr c:recoverytest s:shard1 x:recoverytest_shard1_replica2] o.a.s.c.SolrCore [[recoverytest_shard1_replica2] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsRecoveryZkTest_E3B52153CC2CEEE2-001/tempDir-001/node2/recoverytest_shard1_replica2], dataDir=[hdfs://solaris-vm:44615/data/recoverytest/core_node2/data/]
[junit4] 2> 2272428 INFO (qtp2038592928-27091) [n:127.0.0.1:56506_solr c:recoverytest s:shard1 x:recoverytest_shard1_replica2] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://solaris-vm:44615/data/recoverytest/core_node2/data/snapshot_metadata
[junit4] 2> 2272464 INFO (qtp2058383248-27081) [n:127.0.0.1:43737_solr c:recoverytest s:shard1 x:recoverytest_shard1_replica1] o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct memory allocation set to [true]
[junit4] 2> 2272464 INFO (qtp2058383248-27081) [n:127.0.0.1:43737_solr c:recoverytest s:shard1 x:recoverytest_shard1_replica1] o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of [16777216] will allocate [1] slabs and use ~[16777216] bytes
[junit4] 2> 2272464 INFO (qtp2038592928-27091) [n:127.0.0.1:56506_solr c:recoverytest s:shard1 x:recoverytest_shard1_replica2] o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct memory allocation set to [true]
[junit4] 2> 2272465 INFO (qtp2038592928-27091) [n:127.0.0.1:56506_solr c:recoverytest s:shard1 x:recoverytest_shard1_replica2] o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of [16777216] will allocate [1] slabs and use ~[16777216] bytes
[junit4] 2> 2272467 WARN (qtp2058383248-27081) [n:127.0.0.1:43737_solr c:recoverytest s:shard1 x:recoverytest_shard1_replica1] o.a.s.s.h.HdfsDirectory The NameNode is in SafeMode - Solr will wait 5 seconds and try again.
[junit4] 2> 2272467 WARN (qtp2038592928
[...truncated too long message...]
otsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> Caused by: java.lang.NullPointerException
[junit4] 2> at org.apache.hadoop.hdfs.server.blockmanagement.BlocksMap.size(BlocksMap.java:203)
[junit4] 2> at org.apache.hadoop.hdfs.server.blockmanagement.BlockManager.getTotalBlocks(BlockManager.java:3370)
[junit4] 2> at org.apache.hadoop.hdfs.server.namenode.FSNamesystem.getBlocksTotal(FSNamesystem.java:5729)
[junit4] 2> ... 54 more
[junit4] 2> 2293572 INFO (SUITE-HdfsRecoveryZkTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:55838 55838
[junit4] 2> 2293572 INFO (SUITE-HdfsRecoveryZkTest-seed#[E3B52153CC2CEEE2]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: test params are: codec=CheapBastard, sim=RandomSimilarity(queryNorm=true): {}, locale=lv, timezone=Europe/Moscow
[junit4] 2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_112 (64-bit)/cpus=3,threads=2,free=132775648,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [NumericFieldsTest, TestBlobHandler, TestLegacyNumericRangeQueryBuilder, TestSQLHandler, DistributedFacetPivotSmallTest, HdfsWriteToMultipleCollectionsTest, BasicDistributedZkTest, TestReplicationHandler, TestExactStatsCache, ReplaceNodeTest, HdfsNNFailoverTest, MigrateRouteKeyTest, TestBinaryField, TestFieldCache, TestFieldTypeCollectionResource, DistanceUnitsTest, TestCSVLoader, TestReloadDeadlock, TestOrdValues, SystemInfoHandlerTest, TestFunctionQuery, RuleEngineTest, AnalyticsMergeStrategyTest, TestBlendedInfixSuggestions, TestBulkSchemaAPI, SolrMetricManagerTest, PathHierarchyTokenizerFactoryTest, DOMUtilTest, TermsComponentTest, AnalysisErrorHandlingTest, HdfsSyncSliceTest, AnalysisAfterCoreReloadTest, HLLUtilTest, TestGroupingSearch, TestDocumentBuilder, DistributedQueryComponentCustomSortTest, TestNumericTerms32, SuggesterFSTTest, ParsingFieldUpdateProcessorsTest, TestMissingGroups, BaseCdcrDistributedZkTest, CheckHdfsIndexTest, ConcurrentDeleteAndCreateCollectionTest, DirectUpdateHandlerTest, TestCopyFieldCollectionResource, TestUseDocValuesAsStored, ReplicaListTransformerTest, CloudMLTQParserTest, TestExtendedDismaxParser, TestTolerantUpdateProcessorCloud, QueryElevationComponentTest, TestSolrDeletionPolicy1, CoreMergeIndexesAdminHandlerTest, CollectionStateFormat2Test, TestRTGBase, TestManagedSchemaThreadSafety, TestFieldCacheSanityChecker, MoreLikeThisHandlerTest, TestHdfsUpdateLog, TestSlowCompositeReaderWrapper, TestLeaderElectionWithEmptyReplica, SolrMetricsIntegrationTest, TestFastOutputStream, TestSolrCoreSnapshots, DistributedSuggestComponentTest, TestPseudoReturnFields, DistributedQueueTest, TestConfigSets, SolrCoreTest, DeleteLastCustomShardedReplicaTest, TestLazyCores, TestExclusionRuleCollectionAccess, OutOfBoxZkACLAndCredentialsProvidersTest, TestSimpleQParserPlugin, TestJsonFacets, TestHighlightDedupGrouping, SegmentsInfoRequestHandlerTest, BadCopyFieldTest, TestInitParams, TestLRUCache, UniqFieldsUpdateProcessorFactoryTest, TestCollectionAPI, BufferStoreTest, ZkCLITest, ZkControllerTest, TestClusterStateMutator, TestSchemaNameResource, DirectoryFactoryTest, HardAutoCommitTest, TestCharFilters, ShardSplitTest, TestJettySolrRunner, TestSolrJ, TestXmlQParserPlugin, ConjunctionSolrSpellCheckerTest, SearchHandlerTest, TestFieldCollectionResource, TestManagedResourceStorage, PluginInfoTest, SSLMigrationTest, XmlUpdateRequestHandlerTest, TestDynamicFieldCollectionResource, QueryEqualityTest, TestWordDelimiterFilterFactory, TestOnReconnectListenerSupport, TestSweetSpotSimilarityFactory, TestReRankQParserPlugin, TestCollationField, TestConfigSetImmutable, TestFreeTextSuggestions, TestTrackingShardHandlerFactory, ZkNodePropsTest, TestElisionMultitermQuery, CdcrRequestHandlerTest, TestIBSimilarityFactory, DistributedQueryElevationComponentTest, PeerSyncTest, TestDocBasedVersionConstraints, TestSolrQueryResponse, TestHashQParserPlugin, TestExpandComponent, DistributedDebugComponentTest, TestCollapseQParserPlugin, TestStressReorder, SimpleFacetsTest, TestJmxIntegration, RestartWhileUpdatingTest, TestTrieFacet, SpatialFilterTest, OpenExchangeRatesOrgProviderTest, TestJavabinTupleStreamParser, TestDistribDocBasedVersion, TestSchemaSimilarityResource, TestSolr4Spatial2, CachingDirectoryFactoryTest, TestManagedStopFilterFactory, BasicAuthIntegrationTest, SharedFSAutoReplicaFailoverUtilsTest, TestRequestStatusCollectionAPI, TestCustomStream, IndexSchemaRuntimeFieldTest, GraphQueryTest, TestLeaderInitiatedRecoveryThread, PrimitiveFieldTypeTest, SampleTest, TestCursorMarkWithoutUniqueKey, TestSolrQueryParserResource, TestStressVersions, TestIntervalFaceting, SolrXmlInZkTest, TlogReplayBufferedWhileIndexingTest, TestPerFieldSimilarity, LeaderInitiatedRecoveryOnCommitTest, DirectSolrSpellCheckerTest, TestFastLRUCache, CdcrReplicationDistributedZkTest, OverseerTaskQueueTest, BitVectorTest, CursorMarkTest, DistribDocExpirationUpdateProcessorTest, TestSolrConfigHandlerCloud, TestLFUCache, DocValuesTest, TestRawResponseWriter, OpenCloseCoreStressTest, OverseerTest, BasicZkTest, FullSolrCloudDistribCmdsTest, TestRandomDVFaceting, ShardRoutingCustomTest, TestDistributedSearch, TestRealTimeGet, TestReload, TestCoreContainer, StatsComponentTest, BadIndexSchemaTest, ConvertedLegacyTest, TestSort, HighlighterTest, CurrencyFieldOpenExchangeTest, CurrencyFieldXmlFileTest, SimplePostToolTest, TestCoreDiscovery, SolrRequestParserTest, TestStressLucene, TestTrie, PolyFieldTest, NoCacheHeaderTest, WordBreakSolrSpellCheckerTest, SchemaVersionSpecificBehaviorTest, TestUpdate, DefaultValueUpdateProcessorTest, SortByFunctionTest, TestRemoteStreaming, DocValuesMultiTest, XsltUpdateRequestHandlerTest, DebugComponentTest, IndexBasedSpellCheckerTest, LukeRequestHandlerTest, TestQueryTypes, TestValueSourceCache, RequiredFieldsTest, LoggingHandlerTest, SolrPluginUtilsTest, ReturnFieldsTest, MBeansHandlerTest, TestAnalyzedSuggestions, TestPartialUpdateDeduplication, PingRequestHandlerTest, SpellPossibilityIteratorTest, TestXIncludeConfig, TestLMJelinekMercerSimilarityFactory, TestBM25SimilarityFactory, TimeZoneUtilsTest, DateMathParserTest, TestSystemIdResolver, PrimUtilsTest, DateFieldTest, ClusterStateTest, SliceStateTest, FileUtilsTest, DistributedMLTComponentTest, CursorPagingTest, DistributedIntervalFacetingTest, SolrTestCaseJ4Test, TestCrossCoreJoin, TestDistributedMissingSort, TestSimpleTrackingShardHandler, ActionThrottleTest, AssignTest, AsyncCallRequestStatusResponseTest, CdcrReplicationHandlerTest, CloudExitableDirectoryReaderTest, CollectionsAPIAsyncDistributedZkTest, ConnectionManagerTest, CreateCollectionCleanupTest, CustomCollectionTest, DeleteShardTest, DistribCursorPagingTest, DistribJoinFromCollectionTest, HttpPartitionTest, LeaderInitiatedRecoveryOnShardRestartTest, OverriddenZkACLAndCredentialsProvidersTest, OverseerCollectionConfigSetProcessorTest, OverseerRolesTest, PeerSyncReplicationTest, TestCloudRecovery, TestDownShardTolerantSearch, TestLocalFSCloudBackupRestore, TestMiniSolrCloudClusterSSL, TestReplicaProperties, TestShortCircuitedRequests, TestSolrCloudWithDelegationTokens, TestSolrCloudWithKerberosAlt, TestStressCloudBlindAtomicUpdates, TestStressLiveNodes, TestTolerantUpdateProcessorRandomCloud, HdfsRecoveryZkTest]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=HdfsRecoveryZkTest -Dtests.seed=E3B52153CC2CEEE2 -Dtests.slow=true -Dtests.locale=lv -Dtests.timezone=Europe/Moscow -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.00s J0 | HdfsRecoveryZkTest (suite) <<<
[junit4] > Throwable #1: java.lang.AssertionError: ObjectTracker found 1 object(s) that were not released!!! [HdfsTransactionLog]
[junit4] > org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException
[junit4] > at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:43)
[junit4] > at org.apache.solr.update.HdfsTransactionLog.<init>(HdfsTransactionLog.java:130)
[junit4] > at org.apache.solr.update.HdfsUpdateLog.init(HdfsUpdateLog.java:202)
[junit4] > at org.apache.solr.update.UpdateHandler.<init>(UpdateHandler.java:137)
[junit4] > at org.apache.solr.update.UpdateHandler.<init>(UpdateHandler.java:94)
[junit4] > at org.apache.solr.update.DirectUpdateHandler2.<init>(DirectUpdateHandler2.java:102)
[junit4] > at java.lang.reflect.Constructor.newInstance(Constructor.java:423)
[junit4] > at org.apache.solr.core.SolrCore.createInstance(SolrCore.java:747)
[junit4] > at org.apache.solr.core.SolrCore.createUpdateHandler(SolrCore.java:809)
[junit4] > at org.apache.solr.core.SolrCore.initUpdateHandler(SolrCore.java:1060)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:925)
[junit4] > at org.apache.solr.core.SolrCore.<init>(SolrCore.java:817)
[junit4] > at org.apache.solr.core.CoreContainer.create(CoreContainer.java:906)
[junit4] > at org.apache.solr.core.CoreContainer.lambda$load$3(CoreContainer.java:551)
[junit4] > at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] > at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
[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([E3B52153CC2CEEE2]:0)
[junit4] > at org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:266)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] Completed [532/673 (2!)] on J0 in 56.99s, 1 test, 1 failure <<< FAILURES!
[...truncated 62894 lines...]
Re: [JENKINS] Lucene-Solr-master-Solaris (64bit/jdk1.8.0) - Build #
1046 - Unstable!
Posted by Michael McCandless <lu...@mikemccandless.com>.
FlattenGraphFilter again ... I still need to look into this once I'm
back from vacation.
Mike McCandless
http://blog.mikemccandless.com
On Sat, Dec 31, 2016 at 12:23 PM, Policeman Jenkins Server
<je...@thetaphi.de> wrote:
> Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Solaris/1046/
> Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseG1GC
>
> 1 tests failed.
> FAILED: org.apache.lucene.analysis.core.TestRandomChains.testRandomChainsWithLargeStrings
>
> Error Message:
> pos=6 nextPos=10 count=3
>
> Stack Trace:
> java.lang.AssertionError: pos=6 nextPos=10 count=3
> at __randomizedtesting.SeedInfo.seed([30786A43D63AEC6C:5A23D5528F74CC9F]:0)
> at org.apache.lucene.util.RollingBuffer.get(RollingBuffer.java:105)
> at org.apache.lucene.analysis.synonym.FlattenGraphFilter.releaseBufferedToken(FlattenGraphFilter.java:183)
> at org.apache.lucene.analysis.synonym.FlattenGraphFilter.incrementToken(FlattenGraphFilter.java:264)
> at org.apache.lucene.analysis.ValidatingTokenFilter.incrementToken(ValidatingTokenFilter.java:67)
> at org.apache.lucene.analysis.BaseTokenStreamTestCase.checkAnalysisConsistency(BaseTokenStreamTestCase.java:724)
> at org.apache.lucene.analysis.BaseTokenStreamTestCase.checkRandomData(BaseTokenStreamTestCase.java:635)
> at org.apache.lucene.analysis.BaseTokenStreamTestCase.checkRandomData(BaseTokenStreamTestCase.java:533)
> at org.apache.lucene.analysis.core.TestRandomChains.testRandomChainsWithLargeStrings(TestRandomChains.java:869)
> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> at java.lang.reflect.Method.invoke(Method.java:498)
> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
> at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
> at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
> at java.lang.Thread.run(Thread.java:745)
>
>
>
>
> Build Log:
> [...truncated 2177 lines...]
> [junit4] Suite: org.apache.lucene.analysis.core.TestRandomChains
> [junit4] 2> TEST FAIL: useCharFilter=false text='{1,5}b 10 eaj fishcl \ua707\ua70d\ua710\ua718\ua716\ua70c i EZspcnb janx \u310f\u3115 c \u56fe= k'
> [junit4] 2> Exception from random analyzer:
> [junit4] 2> charfilters=
> [junit4] 2> org.apache.lucene.analysis.charfilter.HTMLStripCharFilter(java.io.StringReader@68fea570, [<HIRAGANA>, <COMPANY>])
> [junit4] 2> org.apache.lucene.analysis.charfilter.HTMLStripCharFilter(org.apache.lucene.analysis.charfilter.HTMLStripCharFilter@271a3439, [<NUM>, <CJ>])
> [junit4] 2> tokenizer=
> [junit4] 2> org.apache.lucene.analysis.standard.UAX29URLEmailTokenizer(org.apache.lucene.util.AttributeFactory$DefaultAttributeFactory@4b2a1fb5)
> [junit4] 2> filters=
> [junit4] 2> org.apache.lucene.analysis.commongrams.CommonGramsQueryFilter(CommonGramsFilter@3d1ac1b1 term=,bytes=[],startOffset=0,endOffset=0,positionIncrement=1,type=word,positionLength=1)
> [junit4] 2> org.apache.lucene.analysis.miscellaneous.KeywordRepeatFilter(ValidatingTokenFilter@74466729 term=,bytes=[],startOffset=0,endOffset=0,positionIncrement=1,type=word,positionLength=1,keyword=false)
> [junit4] 2> org.apache.lucene.analysis.synonym.FlattenGraphFilter(ValidatingTokenFilter@7a23a384 term=,bytes=[],startOffset=0,endOffset=0,positionIncrement=1,type=word,positionLength=1,keyword=false)
> [junit4] 2> offsetsAreCorrect=false
> [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestRandomChains -Dtests.method=testRandomChainsWithLargeStrings -Dtests.seed=30786A43D63AEC6C -Dtests.slow=true -Dtests.locale=el -Dtests.timezone=Pacific/Palau -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
> [junit4] FAILURE 0.47s J1 | TestRandomChains.testRandomChainsWithLargeStrings <<<
> [junit4] > Throwable #1: java.lang.AssertionError: pos=6 nextPos=10 count=3
> [junit4] > at __randomizedtesting.SeedInfo.seed([30786A43D63AEC6C:5A23D5528F74CC9F]:0)
> [junit4] > at org.apache.lucene.util.RollingBuffer.get(RollingBuffer.java:105)
> [junit4] > at org.apache.lucene.analysis.synonym.FlattenGraphFilter.releaseBufferedToken(FlattenGraphFilter.java:183)
> [junit4] > at org.apache.lucene.analysis.synonym.FlattenGraphFilter.incrementToken(FlattenGraphFilter.java:264)
> [junit4] > at org.apache.lucene.analysis.ValidatingTokenFilter.incrementToken(ValidatingTokenFilter.java:67)
> [junit4] > at org.apache.lucene.analysis.BaseTokenStreamTestCase.checkAnalysisConsistency(BaseTokenStreamTestCase.java:724)
> [junit4] > at org.apache.lucene.analysis.BaseTokenStreamTestCase.checkRandomData(BaseTokenStreamTestCase.java:635)
> [junit4] > at org.apache.lucene.analysis.BaseTokenStreamTestCase.checkRandomData(BaseTokenStreamTestCase.java:533)
> [junit4] > at org.apache.lucene.analysis.core.TestRandomChains.testRandomChainsWithLargeStrings(TestRandomChains.java:869)
> [junit4] > at java.lang.Thread.run(Thread.java:745)
> [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {dummy=PostingsFormat(name=LuceneFixedGap)}, docValues:{}, maxPointsInLeafNode=1328, maxMBSortInHeap=6.613126557066521, sim=RandomSimilarity(queryNorm=true): {}, locale=el, timezone=Pacific/Palau
> [junit4] 2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_112 (64-bit)/cpus=3,threads=1,free=240496064,total=314572800
> [junit4] 2> NOTE: All tests run in this JVM: [TestClassicAnalyzer, TestLimitTokenCountFilterFactory, TestHunspellStemFilterFactory, EdgeNGramTokenizerTest, TestSwedishLightStemFilterFactory, TestRussianLightStemFilterFactory, TestUAX29URLEmailAnalyzer, TestRandomChains]
> [junit4] Completed [14/275 (1!)] on J1 in 3.32s, 2 tests, 1 failure <<< FAILURES!
>
> [...truncated 73009 lines...]
>
>
>
> ---------------------------------------------------------------------
> To unsubscribe, e-mail: dev-unsubscribe@lucene.apache.org
> For additional commands, e-mail: dev-help@lucene.apache.org
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@lucene.apache.org
For additional commands, e-mail: dev-help@lucene.apache.org