Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-master/1518/
4 tests failed. FAILED: org.apache.solr.cloud.FullSolrCloudDistribCmdsTest.test Error Message: Test abandoned because suite timeout was reached. Stack Trace: java.lang.Exception: Test abandoned because suite timeout was reached. at __randomizedtesting.SeedInfo.seed([A81891ADF121A048]:0) FAILED: junit.framework.TestSuite.org.apache.solr.cloud.FullSolrCloudDistribCmdsTest Error Message: Java heap space Stack Trace: java.lang.OutOfMemoryError: Java heap space FAILED: org.apache.solr.handler.TestReplicationHandler.doTestReplicateAfterCoreReload Error Message: expected:<[{indexVersion=1522627347299,generation=2,filelist=[_hg2.fdt, _hg2.fdx, _hg2.fnm, _hg2.nvd, _hg2.nvm, _hg2.si, _hg2_LuceneVarGapFixedInterval_0.doc, _hg2_LuceneVarGapFixedInterval_0.tib, _hg2_LuceneVarGapFixedInterval_0.tiv, _hkt.fdt, _hkt.fdx, _hkt.fnm, _hkt.nvd, _hkt.nvm, _hkt.si, _hkt_LuceneVarGapFixedInterval_0.doc, _hkt_LuceneVarGapFixedInterval_0.tib, _hkt_LuceneVarGapFixedInterval_0.tiv, _hku.cfe, _hku.cfs, _hku.si, _hkv.cfe, _hkv.cfs, _hkv.si, _hkw.cfe, _hkw.cfs, _hkw.si, _hkx.cfe, _hkx.cfs, _hkx.si, _hky.cfe, _hky.cfs, _hky.si, _hkz.cfe, _hkz.cfs, _hkz.si, _hl0.cfe, _hl0.cfs, _hl0.si, _hl1.cfe, _hl1.cfs, _hl1.si, _hl2.cfe, _hl2.cfs, _hl2.si, _hl3.cfe, _hl3.cfs, _hl3.si, _hl4.cfe, _hl4.cfs, _hl4.si, _hl5.cfe, _hl5.cfs, _hl5.si, _hl6.cfe, _hl6.cfs, _hl6.si, _hl7.cfe, _hl7.cfs, _hl7.si, _hl8.cfe, _hl8.cfs, _hl8.si, _hl9.cfe, _hl9.cfs, _hl9.si, _hla.cfe, _hla.cfs, _hla.si, _hlb.cfe, _hlb.cfs, _hlb.si, _hlc.cfe, _hlc.cfs, _hlc.si, _hld.cfe, _hld.cfs, _hld.si, _hle.cfe, _hle.cfs, _hle.si, _hlf.cfe, _hlf.cfs, _hlf.si, _hlg.cfe, _hlg.cfs, _hlg.si, _hlh.cfe, _hlh.cfs, _hlh.si, _hli.cfe, _hli.cfs, _hli.si, _hlj.cfe, _hlj.cfs, _hlj.si, _hlk.cfe, _hlk.cfs, _hlk.si, _hll.cfe, _hll.cfs, _hll.si, _hlm.cfe, _hlm.cfs, _hlm.si, _hln.cfe, _hln.cfs, _hln.si, _hlo.cfe, _hlo.cfs, _hlo.si, _hlp.cfe, _hlp.cfs, _hlp.si, _hnn.cfe, _hnn.cfs, _hnn.si, _hno.cfe, _hno.cfs, _hno.si, _hnp.fdt, _hnp.fdx, _hnp.fnm, _hnp.nvd, _hnp.nvm, _hnp.si, _hnp_LuceneVarGapFixedInterval_0.doc, _hnp_LuceneVarGapFixedInterval_0.tib, _hnp_LuceneVarGapFixedInterval_0.tiv, _hnq.cfe, _hnq.cfs, _hnq.si, _hnr.cfe, _hnr.cfs, _hnr.si, _hns.cfe, _hns.cfs, _hns.si, _hnt.cfe, _hnt.cfs, _hnt.si, _hnu.cfe, _hnu.cfs, _hnu.si, _hnv.cfe, _hnv.cfs, _hnv.si, _hnw.cfe, _hnw.cfs, _hnw.si, _hnx.cfe, _hnx.cfs, _hnx.si, _hny.cfe, _hny.cfs, _hny.si, _hnz.cfe, _hnz.cfs, _hnz.si, segments_2]}]> but was:<[{indexVersion=1522627347299,generation=2,filelist=[_hg2.fdt, _hg2.fdx, _hg2.fnm, _hg2.nvd, _hg2.nvm, _hg2.si, _hg2_LuceneVarGapFixedInterval_0.doc, _hg2_LuceneVarGapFixedInterval_0.tib, _hg2_LuceneVarGapFixedInterval_0.tiv, _hkt.fdt, _hkt.fdx, _hkt.fnm, _hkt.nvd, _hkt.nvm, _hkt.si, _hkt_LuceneVarGapFixedInterval_0.doc, _hkt_LuceneVarGapFixedInterval_0.tib, _hkt_LuceneVarGapFixedInterval_0.tiv, _hku.cfe, _hku.cfs, _hku.si, _hkv.cfe, _hkv.cfs, _hkv.si, _hkw.cfe, _hkw.cfs, _hkw.si, _hkx.cfe, _hkx.cfs, _hkx.si, _hky.cfe, _hky.cfs, _hky.si, _hkz.cfe, _hkz.cfs, _hkz.si, _hl0.cfe, _hl0.cfs, _hl0.si, _hl1.cfe, _hl1.cfs, _hl1.si, _hl2.cfe, _hl2.cfs, _hl2.si, _hl3.cfe, _hl3.cfs, _hl3.si, _hl4.cfe, _hl4.cfs, _hl4.si, _hl5.cfe, _hl5.cfs, _hl5.si, _hl6.cfe, _hl6.cfs, _hl6.si, _hl7.cfe, _hl7.cfs, _hl7.si, _hl8.cfe, _hl8.cfs, _hl8.si, _hl9.cfe, _hl9.cfs, _hl9.si, _hla.cfe, _hla.cfs, _hla.si, _hlb.cfe, _hlb.cfs, _hlb.si, _hlc.cfe, _hlc.cfs, _hlc.si, _hld.cfe, _hld.cfs, _hld.si, _hle.cfe, _hle.cfs, _hle.si, _hlf.cfe, _hlf.cfs, _hlf.si, _hlg.cfe, _hlg.cfs, _hlg.si, _hlh.cfe, _hlh.cfs, _hlh.si, _hli.cfe, _hli.cfs, _hli.si, _hlj.cfe, _hlj.cfs, _hlj.si, _hlk.cfe, _hlk.cfs, _hlk.si, _hll.cfe, _hll.cfs, _hll.si, _hlm.cfe, _hlm.cfs, _hlm.si, _hln.cfe, _hln.cfs, _hln.si, _hlo.cfe, _hlo.cfs, _hlo.si, _hlp.cfe, _hlp.cfs, _hlp.si, _hnn.cfe, _hnn.cfs, _hnn.si, _hno.cfe, _hno.cfs, _hno.si, _hnp.fdt, _hnp.fdx, _hnp.fnm, _hnp.nvd, _hnp.nvm, _hnp.si, _hnp_LuceneVarGapFixedInterval_0.doc, _hnp_LuceneVarGapFixedInterval_0.tib, _hnp_LuceneVarGapFixedInterval_0.tiv, _hnq.cfe, _hnq.cfs, _hnq.si, _hnr.cfe, _hnr.cfs, _hnr.si, _hns.cfe, _hns.cfs, _hns.si, _hnt.cfe, _hnt.cfs, _hnt.si, _hnu.cfe, _hnu.cfs, _hnu.si, _hnv.cfe, _hnv.cfs, _hnv.si, _hnw.cfe, _hnw.cfs, _hnw.si, _hnx.cfe, _hnx.cfs, _hnx.si, _hny.cfe, _hny.cfs, _hny.si, _hnz.cfe, _hnz.cfs, _hnz.si, segments_2]}, {indexVersion=1522627347299,generation=3,filelist=[_hlq.fdt, _hlq.fdx, _hlq.fnm, _hlq.nvd, _hlq.nvm, _hlq.si, _hlq_LuceneVarGapFixedInterval_0.doc, _hlq_LuceneVarGapFixedInterval_0.tib, _hlq_LuceneVarGapFixedInterval_0.tiv, _hnn.cfe, _hnn.cfs, _hnn.si, _hno.cfe, _hno.cfs, _hno.si, _hnp.fdt, _hnp.fdx, _hnp.fnm, _hnp.nvd, _hnp.nvm, _hnp.si, _hnp_LuceneVarGapFixedInterval_0.doc, _hnp_LuceneVarGapFixedInterval_0.tib, _hnp_LuceneVarGapFixedInterval_0.tiv, _hnq.cfe, _hnq.cfs, _hnq.si, _hnr.cfe, _hnr.cfs, _hnr.si, _hns.cfe, _hns.cfs, _hns.si, _hnt.cfe, _hnt.cfs, _hnt.si, _hnu.cfe, _hnu.cfs, _hnu.si, _hnv.cfe, _hnv.cfs, _hnv.si, _hnw.cfe, _hnw.cfs, _hnw.si, _hnx.cfe, _hnx.cfs, _hnx.si, _hny.cfe, _hny.cfs, _hny.si, _hnz.cfe, _hnz.cfs, _hnz.si, segments_3]}]> Stack Trace: java.lang.AssertionError: expected:<[{indexVersion=1522627347299,generation=2,filelist=[_hg2.fdt, _hg2.fdx, _hg2.fnm, _hg2.nvd, _hg2.nvm, _hg2.si, _hg2_LuceneVarGapFixedInterval_0.doc, _hg2_LuceneVarGapFixedInterval_0.tib, _hg2_LuceneVarGapFixedInterval_0.tiv, _hkt.fdt, _hkt.fdx, _hkt.fnm, _hkt.nvd, _hkt.nvm, _hkt.si, _hkt_LuceneVarGapFixedInterval_0.doc, _hkt_LuceneVarGapFixedInterval_0.tib, _hkt_LuceneVarGapFixedInterval_0.tiv, _hku.cfe, _hku.cfs, _hku.si, _hkv.cfe, _hkv.cfs, _hkv.si, _hkw.cfe, _hkw.cfs, _hkw.si, _hkx.cfe, _hkx.cfs, _hkx.si, _hky.cfe, _hky.cfs, _hky.si, _hkz.cfe, _hkz.cfs, _hkz.si, _hl0.cfe, _hl0.cfs, _hl0.si, _hl1.cfe, _hl1.cfs, _hl1.si, _hl2.cfe, _hl2.cfs, _hl2.si, _hl3.cfe, _hl3.cfs, _hl3.si, _hl4.cfe, _hl4.cfs, _hl4.si, _hl5.cfe, _hl5.cfs, _hl5.si, _hl6.cfe, _hl6.cfs, _hl6.si, _hl7.cfe, _hl7.cfs, _hl7.si, _hl8.cfe, _hl8.cfs, _hl8.si, _hl9.cfe, _hl9.cfs, _hl9.si, _hla.cfe, _hla.cfs, _hla.si, _hlb.cfe, _hlb.cfs, _hlb.si, _hlc.cfe, _hlc.cfs, _hlc.si, _hld.cfe, _hld.cfs, _hld.si, _hle.cfe, _hle.cfs, _hle.si, _hlf.cfe, _hlf.cfs, _hlf.si, _hlg.cfe, _hlg.cfs, _hlg.si, _hlh.cfe, _hlh.cfs, _hlh.si, _hli.cfe, _hli.cfs, _hli.si, _hlj.cfe, _hlj.cfs, _hlj.si, _hlk.cfe, _hlk.cfs, _hlk.si, _hll.cfe, _hll.cfs, _hll.si, _hlm.cfe, _hlm.cfs, _hlm.si, _hln.cfe, _hln.cfs, _hln.si, _hlo.cfe, _hlo.cfs, _hlo.si, _hlp.cfe, _hlp.cfs, _hlp.si, _hnn.cfe, _hnn.cfs, _hnn.si, _hno.cfe, _hno.cfs, _hno.si, _hnp.fdt, _hnp.fdx, _hnp.fnm, _hnp.nvd, _hnp.nvm, _hnp.si, _hnp_LuceneVarGapFixedInterval_0.doc, _hnp_LuceneVarGapFixedInterval_0.tib, _hnp_LuceneVarGapFixedInterval_0.tiv, _hnq.cfe, _hnq.cfs, _hnq.si, _hnr.cfe, _hnr.cfs, _hnr.si, _hns.cfe, _hns.cfs, _hns.si, _hnt.cfe, _hnt.cfs, _hnt.si, _hnu.cfe, _hnu.cfs, _hnu.si, _hnv.cfe, _hnv.cfs, _hnv.si, _hnw.cfe, _hnw.cfs, _hnw.si, _hnx.cfe, _hnx.cfs, _hnx.si, _hny.cfe, _hny.cfs, _hny.si, _hnz.cfe, _hnz.cfs, _hnz.si, segments_2]}]> but was:<[{indexVersion=1522627347299,generation=2,filelist=[_hg2.fdt, _hg2.fdx, _hg2.fnm, _hg2.nvd, _hg2.nvm, _hg2.si, _hg2_LuceneVarGapFixedInterval_0.doc, _hg2_LuceneVarGapFixedInterval_0.tib, _hg2_LuceneVarGapFixedInterval_0.tiv, _hkt.fdt, _hkt.fdx, _hkt.fnm, _hkt.nvd, _hkt.nvm, _hkt.si, _hkt_LuceneVarGapFixedInterval_0.doc, _hkt_LuceneVarGapFixedInterval_0.tib, _hkt_LuceneVarGapFixedInterval_0.tiv, _hku.cfe, _hku.cfs, _hku.si, _hkv.cfe, _hkv.cfs, _hkv.si, _hkw.cfe, _hkw.cfs, _hkw.si, _hkx.cfe, _hkx.cfs, _hkx.si, _hky.cfe, _hky.cfs, _hky.si, _hkz.cfe, _hkz.cfs, _hkz.si, _hl0.cfe, _hl0.cfs, _hl0.si, _hl1.cfe, _hl1.cfs, _hl1.si, _hl2.cfe, _hl2.cfs, _hl2.si, _hl3.cfe, _hl3.cfs, _hl3.si, _hl4.cfe, _hl4.cfs, _hl4.si, _hl5.cfe, _hl5.cfs, _hl5.si, _hl6.cfe, _hl6.cfs, _hl6.si, _hl7.cfe, _hl7.cfs, _hl7.si, _hl8.cfe, _hl8.cfs, _hl8.si, _hl9.cfe, _hl9.cfs, _hl9.si, _hla.cfe, _hla.cfs, _hla.si, _hlb.cfe, _hlb.cfs, _hlb.si, _hlc.cfe, _hlc.cfs, _hlc.si, _hld.cfe, _hld.cfs, _hld.si, _hle.cfe, _hle.cfs, _hle.si, _hlf.cfe, _hlf.cfs, _hlf.si, _hlg.cfe, _hlg.cfs, _hlg.si, _hlh.cfe, _hlh.cfs, _hlh.si, _hli.cfe, _hli.cfs, _hli.si, _hlj.cfe, _hlj.cfs, _hlj.si, _hlk.cfe, _hlk.cfs, _hlk.si, _hll.cfe, _hll.cfs, _hll.si, _hlm.cfe, _hlm.cfs, _hlm.si, _hln.cfe, _hln.cfs, _hln.si, _hlo.cfe, _hlo.cfs, _hlo.si, _hlp.cfe, _hlp.cfs, _hlp.si, _hnn.cfe, _hnn.cfs, _hnn.si, _hno.cfe, _hno.cfs, _hno.si, _hnp.fdt, _hnp.fdx, _hnp.fnm, _hnp.nvd, _hnp.nvm, _hnp.si, _hnp_LuceneVarGapFixedInterval_0.doc, _hnp_LuceneVarGapFixedInterval_0.tib, _hnp_LuceneVarGapFixedInterval_0.tiv, _hnq.cfe, _hnq.cfs, _hnq.si, _hnr.cfe, _hnr.cfs, _hnr.si, _hns.cfe, _hns.cfs, _hns.si, _hnt.cfe, _hnt.cfs, _hnt.si, _hnu.cfe, _hnu.cfs, _hnu.si, _hnv.cfe, _hnv.cfs, _hnv.si, _hnw.cfe, _hnw.cfs, _hnw.si, _hnx.cfe, _hnx.cfs, _hnx.si, _hny.cfe, _hny.cfs, _hny.si, _hnz.cfe, _hnz.cfs, _hnz.si, segments_2]}, {indexVersion=1522627347299,generation=3,filelist=[_hlq.fdt, _hlq.fdx, _hlq.fnm, _hlq.nvd, _hlq.nvm, _hlq.si, _hlq_LuceneVarGapFixedInterval_0.doc, _hlq_LuceneVarGapFixedInterval_0.tib, _hlq_LuceneVarGapFixedInterval_0.tiv, _hnn.cfe, _hnn.cfs, _hnn.si, _hno.cfe, _hno.cfs, _hno.si, _hnp.fdt, _hnp.fdx, _hnp.fnm, _hnp.nvd, _hnp.nvm, _hnp.si, _hnp_LuceneVarGapFixedInterval_0.doc, _hnp_LuceneVarGapFixedInterval_0.tib, _hnp_LuceneVarGapFixedInterval_0.tiv, _hnq.cfe, _hnq.cfs, _hnq.si, _hnr.cfe, _hnr.cfs, _hnr.si, _hns.cfe, _hns.cfs, _hns.si, _hnt.cfe, _hnt.cfs, _hnt.si, _hnu.cfe, _hnu.cfs, _hnu.si, _hnv.cfe, _hnv.cfs, _hnv.si, _hnw.cfe, _hnw.cfs, _hnw.si, _hnx.cfe, _hnx.cfs, _hnx.si, _hny.cfe, _hny.cfs, _hny.si, _hnz.cfe, _hnz.cfs, _hnz.si, segments_3]}]> at __randomizedtesting.SeedInfo.seed([A81891ADF121A048:8DCF8A9D8169AE4B]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.failNotEquals(Assert.java:647) at org.junit.Assert.assertEquals(Assert.java:128) at org.junit.Assert.assertEquals(Assert.java:147) at org.apache.solr.handler.TestReplicationHandler.doTestReplicateAfterCoreReload(TestReplicationHandler.java:1285) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.lang.Thread.run(Thread.java:748) FAILED: junit.framework.TestSuite.org.apache.solr.spelling.suggest.SuggesterWFSTTest Error Message: Stack Trace: java.lang.AssertionError at __randomizedtesting.SeedInfo.seed([A81891ADF121A048]:0) at org.apache.lucene.util.TestRuleTemporaryFilesCleanup.before(TestRuleTemporaryFilesCleanup.java:112) at com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.before(TestRuleAdapter.java:26) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:35) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.lang.Thread.run(Thread.java:748) Build Log: [...truncated 2155 lines...] [junit4] JVM J2: stdout was not empty, see: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/lucene/build/core/test/temp/junit4-J2-20180401_170427_4094763042186197287243.sysout [junit4] >>> JVM J2 emitted unexpected output (verbatim) ---- [junit4] codec: CheapBastard, pf: MockRandom, dvf: Direct [junit4] <<< JVM J2: EOF ---- [...truncated 11320 lines...] [junit4] Suite: org.apache.solr.handler.TestReplicationHandler [junit4] 2> Creating dataDir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/init-core-data-001 [junit4] 2> 1352066 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T17:27:37-04:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 1352086 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 1352086 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 1352086 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.e.j.s.session Scavenging every 660000ms [junit4] 2> 1352087 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@a4236bd{/solr,null,AVAILABLE} [junit4] 2> 1352105 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@3d7bc796{HTTP/1.1,[http/1.1]}{127.0.0.1:38880} [junit4] 2> 1352105 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.e.j.s.Server Started @1352302ms [junit4] 2> 1352106 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/solr-instance-001/collection1/data, hostContext=/solr, hostPort=38880} [junit4] 2> 1352106 ERROR (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 1352106 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 1352106 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0 [junit4] 2> 1352106 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 1352106 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 1352106 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-04-01T23:53:23.448Z [junit4] 2> 1352106 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/solr-instance-001/solr.xml [junit4] 2> 1352123 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 1352123 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 1352124 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@4cfa135c, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 1352237 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4cfa135c [junit4] 2> 1352253 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4cfa135c [junit4] 2> 1352254 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4cfa135c [junit4] 2> 1352268 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/solr-instance-001/. [junit4] 2> 1352268 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 1352268 INFO (coreLoadExecutor-1554-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 1352304 INFO (coreLoadExecutor-1554-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 1352331 INFO (coreLoadExecutor-1554-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1352333 INFO (coreLoadExecutor-1554-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id [junit4] 2> 1352333 INFO (coreLoadExecutor-1554-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/solr-instance-001/./collection1, trusted=true [junit4] 2> 1352334 INFO (coreLoadExecutor-1554-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4cfa135c [junit4] 2> 1352334 INFO (coreLoadExecutor-1554-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 1352334 INFO (coreLoadExecutor-1554-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/solr-instance-001/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/solr-instance-001/./collection1/data/] [junit4] 2> 1352352 INFO (coreLoadExecutor-1554-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=28, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5158197866113737] [junit4] 2> 1352474 INFO (coreLoadExecutor-1554-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1352474 INFO (coreLoadExecutor-1554-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1352475 INFO (coreLoadExecutor-1554-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=34, maxMergeAtOnceExplicit=13, maxMergedSegmentMB=88.1201171875, floorSegmentMB=0.2119140625, forceMergeDeletesPctAllowed=13.67040527507545, segmentsPerTier=28.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 1352475 INFO (coreLoadExecutor-1554-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@60499fd[collection1] main] [junit4] 2> 1352475 INFO (coreLoadExecutor-1554-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/solr-instance-001/collection1/conf [junit4] 2> 1352476 INFO (coreLoadExecutor-1554-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl [junit4] 2> 1352476 INFO (coreLoadExecutor-1554-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 1352477 INFO (searcherExecutor-1555-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@60499fd[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1352481 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T17:27:37-04:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 1352482 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 1352482 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 1352482 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.e.j.s.session Scavenging every 660000ms [junit4] 2> 1352482 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5c834b91{/solr,null,AVAILABLE} [junit4] 2> 1352482 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@655bf597{HTTP/1.1,[http/1.1]}{127.0.0.1:44405} [junit4] 2> 1352482 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.e.j.s.Server Started @1352679ms [junit4] 2> 1352482 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/solr-instance-002/collection1/data, hostContext=/solr, hostPort=44405} [junit4] 2> 1352483 ERROR (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 1352483 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 1352483 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0 [junit4] 2> 1352483 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 1352483 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 1352483 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-04-01T23:53:23.825Z [junit4] 2> 1352483 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/solr-instance-002/solr.xml [junit4] 2> 1352507 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 1352507 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 1352508 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@4cfa135c, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 1352630 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4cfa135c [junit4] 2> 1352656 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4cfa135c [junit4] 2> 1352656 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4cfa135c [junit4] 2> 1352658 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/solr-instance-002/. [junit4] 2> 1352658 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 1352658 INFO (coreLoadExecutor-1564-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 1352764 INFO (coreLoadExecutor-1564-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 1352795 INFO (coreLoadExecutor-1564-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1352797 INFO (coreLoadExecutor-1564-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id [junit4] 2> 1352797 INFO (coreLoadExecutor-1564-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/solr-instance-002/./collection1, trusted=true [junit4] 2> 1352797 INFO (coreLoadExecutor-1564-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4cfa135c [junit4] 2> 1352798 INFO (coreLoadExecutor-1564-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 1352798 INFO (coreLoadExecutor-1564-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/solr-instance-002/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/solr-instance-002/./collection1/data/] [junit4] 2> 1352801 INFO (coreLoadExecutor-1564-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=28, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5158197866113737] [junit4] 2> 1352938 INFO (coreLoadExecutor-1564-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1352938 INFO (coreLoadExecutor-1564-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1352939 INFO (coreLoadExecutor-1564-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=34, maxMergeAtOnceExplicit=13, maxMergedSegmentMB=88.1201171875, floorSegmentMB=0.2119140625, forceMergeDeletesPctAllowed=13.67040527507545, segmentsPerTier=28.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 1352951 INFO (coreLoadExecutor-1564-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@625bcb13[collection1] main] [junit4] 2> 1352952 INFO (coreLoadExecutor-1564-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/solr-instance-002/collection1/conf [junit4] 2> 1352953 INFO (coreLoadExecutor-1564-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms [junit4] 2> 1352953 INFO (coreLoadExecutor-1564-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 1352954 INFO (searcherExecutor-1565-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@625bcb13[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1352964 INFO (qtp1326082431-6189) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0 [junit4] 2> 1352965 INFO (indexFetcher-1569-thread-1) [ ] o.a.s.h.IndexFetcher Master's generation: 1 [junit4] 2> 1352965 INFO (indexFetcher-1569-thread-1) [ ] o.a.s.h.IndexFetcher Master's version: 0 [junit4] 2> 1352965 INFO (indexFetcher-1569-thread-1) [ ] o.a.s.h.IndexFetcher Slave's generation: 1 [junit4] 2> 1352965 INFO (indexFetcher-1569-thread-1) [ ] o.a.s.h.IndexFetcher Slave's version: 0 [junit4] 2> 1352965 INFO (indexFetcher-1569-thread-1) [ ] o.a.s.h.IndexFetcher New index in Master. Deleting mine... [junit4] 2> 1352967 INFO (indexFetcher-1569-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@61b86157[collection1] main] [junit4] 2> 1352967 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@3d7bc796{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 1352967 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=2125683096 [junit4] 2> 1352967 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 1352967 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1f5032fe: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@258d855d [junit4] 2> 1352968 INFO (searcherExecutor-1565-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@61b86157[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1352979 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 1352979 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@39733180: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@44f351cf [junit4] 2> 1352994 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 1352994 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@263e9f79: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@1dc00eb [junit4] 2> 1352995 INFO (coreCloseExecutor-1570-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@441484d [junit4] 2> 1352995 INFO (coreCloseExecutor-1570-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=441484d [junit4] 2> 1352995 INFO (coreCloseExecutor-1570-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@7a7eb86b: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@668a0ccd [junit4] 2> 1353002 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@a4236bd{/solr,null,UNAVAILABLE} [junit4] 2> 1353003 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.e.j.s.session Stopped scavenging [junit4] 2> 1353017 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@655bf597{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 1353017 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=674862999 [junit4] 2> 1353017 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 1353017 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3c952be9: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@5da9be39 [junit4] 2> 1353022 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 1353022 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@26e68a89: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@44f351cf [junit4] 2> 1353042 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 1353042 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2b8bc227: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@1dc00eb [junit4] 2> 1353043 INFO (coreCloseExecutor-1572-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1e36ff33 [junit4] 2> 1353043 INFO (coreCloseExecutor-1572-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=1e36ff33 [junit4] 2> 1353043 INFO (coreCloseExecutor-1572-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4778ee5f: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@303d61be [junit4] 2> 1353060 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5c834b91{/solr,null,UNAVAILABLE} [junit4] 2> 1353060 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A81891ADF121A048]) [ ] o.e.j.s.session Stopped scavenging [junit4] 2> 1353073 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T17:27:37-04:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 1353073 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 1353074 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 1353074 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.e.j.s.session Scavenging every 660000ms [junit4] 2> 1353074 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@497e6455{/solr,null,AVAILABLE} [junit4] 2> 1353074 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@71835f90{HTTP/1.1,[http/1.1]}{127.0.0.1:37981} [junit4] 2> 1353074 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.e.j.s.Server Started @1353271ms [junit4] 2> 1353074 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/solr-instance-003/collection1/data, hostContext=/solr, hostPort=37981} [junit4] 2> 1353075 ERROR (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 1353075 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 1353075 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0 [junit4] 2> 1353075 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 1353075 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 1353075 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-04-01T23:53:24.417Z [junit4] 2> 1353075 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/solr-instance-003/solr.xml [junit4] 2> 1353095 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 1353095 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 1353096 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@4cfa135c, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 1353191 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4cfa135c [junit4] 2> 1353207 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4cfa135c [junit4] 2> 1353207 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4cfa135c [junit4] 2> 1353210 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/solr-instance-003/. [junit4] 2> 1353210 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 1353210 INFO (coreLoadExecutor-1579-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 1353248 INFO (coreLoadExecutor-1579-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 1353281 INFO (coreLoadExecutor-1579-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1353283 INFO (coreLoadExecutor-1579-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id [junit4] 2> 1353283 INFO (coreLoadExecutor-1579-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/solr-instance-003/./collection1, trusted=true [junit4] 2> 1353283 INFO (coreLoadExecutor-1579-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4cfa135c [junit4] 2> 1353283 INFO (coreLoadExecutor-1579-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 1353283 INFO (coreLoadExecutor-1579-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/solr-instance-003/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/solr-instance-003/./collection1/data/] [junit4] 2> 1353284 INFO (coreLoadExecutor-1579-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=28, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5158197866113737] [junit4] 2> 1353397 INFO (coreLoadExecutor-1579-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1353397 INFO (coreLoadExecutor-1579-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1353398 INFO (coreLoadExecutor-1579-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=34, maxMergeAtOnceExplicit=13, maxMergedSegmentMB=88.1201171875, floorSegmentMB=0.2119140625, forceMergeDeletesPctAllowed=13.67040527507545, segmentsPerTier=28.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 1353398 INFO (coreLoadExecutor-1579-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@80246d8[collection1] main] [junit4] 2> 1353398 INFO (coreLoadExecutor-1579-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/solr-instance-003/collection1/conf [junit4] 2> 1353399 INFO (coreLoadExecutor-1579-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl [junit4] 2> 1353399 INFO (coreLoadExecutor-1579-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 1353400 INFO (searcherExecutor-1580-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@80246d8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1353404 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T17:27:37-04:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 1353497 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 1353497 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 1353497 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.e.j.s.session Scavenging every 600000ms [junit4] 2> 1353498 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1c514c24{/solr,null,AVAILABLE} [junit4] 2> 1353498 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@53871d21{HTTP/1.1,[http/1.1]}{127.0.0.1:41344} [junit4] 2> 1353498 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.e.j.s.Server Started @1353695ms [junit4] 2> 1353498 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/solr-instance-004/collection1/data, hostContext=/solr, hostPort=41344} [junit4] 2> 1353498 ERROR (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 1353498 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 1353498 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0 [junit4] 2> 1353498 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 1353498 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 1353499 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-04-01T23:53:24.840Z [junit4] 2> 1353499 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/solr-instance-004/solr.xml [junit4] 2> 1353511 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 1353511 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 1353512 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@4cfa135c, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 1353650 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4cfa135c [junit4] 2> 1353683 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4cfa135c [junit4] 2> 1353683 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4cfa135c [junit4] 2> 1353685 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/solr-instance-004/. [junit4] 2> 1353685 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[A81891ADF121A048]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 1353686 INFO (coreLoadExecutor-1589-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 1353721 INFO (coreLoadExecutor-1589-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 1353744 INFO (coreLoadExecutor-1589-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1353753 INFO (coreLoadExecutor-1589-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id [junit4] 2> 1353754 INFO (coreLoadExecutor-1589-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/solr-instance-004/./collection1, trusted=true [junit4] 2> 1353754 INFO (coreLoadExecutor-1589-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4cfa135c [junit4] 2> 1353754 INFO (coreLoadExecutor-1589-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 1353754 INFO (coreLoadExecutor-1589-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/solr-instance-004/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/solr-instance-004/./collection1/data/] [junit4] 2> 1353756 INFO (coreLoadExecutor-1589-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=28, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5158197866113737] [junit4] 2> 1353900 INFO (coreLoadExecutor-1589-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1353900 INFO (coreLoadExecutor-1589-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1353901 INFO (coreLoadExecutor-1589-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=34, maxMergeAtOnceExplicit=13, maxMergedSegmentMB=88.1201171875, floorSegmentMB=0.2119140625, forceMergeDeletesPctAllowed=13.67040527507545, segmentsPerTier=28.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 1353901 INFO (coreLoadExecutor-1589-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@328c613e[collection1] main] [junit4] 2> 1353901 INFO (coreLoadExecutor-1589-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A81891ADF121A048-001/solr-instance-004/collection1/conf [junit4] 2> 1353903 INFO (coreLoadExecutor-1589-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms [junit4] 2> 1353903 INFO (coreLoadExecutor-1589-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 1353905 INFO (searcherExecutor-1590-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@328c613e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1353920 INFO (qtp156508328-6230) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=13 [junit4] 2> 1353920 INFO (indexFetcher-1594-thread-1) [ ] o.a.s.h.IndexFetcher Master's generation: 1 [junit4] 2> 1353920 INFO (indexFetcher-1594-thread-1) [ ] o.a.s.h.IndexFetcher Master's version: 0 [junit4] 2> 1353920 INFO (indexFetcher-1594-thread-1) [ ] o.a.s.h.IndexFetcher Slave's generation: 1 [junit4] 2> 1353920 INFO (indexFetcher-1594-thread-1) [ ] o.a.s.h.IndexFetcher Slave's version: 0 [junit4] 2> 1353920 INFO (indexFetcher-1594-thread-1) [ ] o.a.s.h.IndexFetcher New index in Master. Deleting mine... [junit4] 2> 1353920 INFO (qtp156508328-6232) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 1353923 INFO (indexFetcher-1594-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@4ae24aa6[collection1] main] [junit4] 2> 1353941 INFO (searcherExecutor-1590-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4ae24aa6[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1353949 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[0]} 0 26 [junit4] 2> 1353950 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[1]} 0 0 [junit4] 2> 1353950 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[2]} 0 0 [junit4] 2> 1353951 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[3]} 0 0 [junit4] 2> 1353951 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[4]} 0 0 [junit4] 2> 1353952 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[5]} 0 0 [junit4] 2> 1353952 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[6]} 0 0 [junit4] 2> 1353952 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[7]} 0 0 [junit4] 2> 1353968 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[8]} 0 15 [junit4] 2> 1353970 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[9]} 0 0 [junit4] 2> 1353970 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[10]} 0 0 [junit4] 2> 1353972 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[11]} 0 0 [junit4] 2> 1353973 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[12]} 0 0 [junit4] 2> 1353973 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[13]} 0 0 [junit4] 2> 1353974 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[14]} 0 0 [junit4] 2> 1353974 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[15]} 0 0 [junit4] 2> 1353974 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[16]} 0 0 [junit4] 2> 1353977 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[17]} 0 2 [junit4] 2> 1353998 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[18]} 0 20 [junit4] 2> 1353999 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[19]} 0 0 [junit4] 2> 1354000 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[20]} 0 0 [junit4] 2> 1354000 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[21]} 0 0 [junit4] 2> 1354002 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[22]} 0 0 [junit4] 2> 1354003 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[23]} 0 0 [junit4] 2> 1354004 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[24]} 0 0 [junit4] 2> 1354004 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[25]} 0 0 [junit4] 2> 1354032 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[26]} 0 2 [junit4] 2> 1354062 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[27]} 0 0 [junit4] 2> 1354062 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[28]} 0 0 [junit4] 2> 1354063 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[29]} 0 0 [junit4] 2> 1354063 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[30]} 0 0 [junit4] 2> 1354063 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[31]} 0 0 [junit4] 2> 1354064 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[32]} 0 0 [junit4] 2> 1354064 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[33]} 0 0 [junit4] 2> 1354065 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[34]} 0 0 [junit4] 2> 1354188 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[35]} 0 123 [junit4] 2> 1354189 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[36]} 0 0 [junit4] 2> 1354190 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[37]} 0 0 [junit4] 2> 1354190 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[38]} 0 0 [junit4] 2> 1354191 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[39]} 0 0 [junit4] 2> 1354203 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[40]} 0 0 [junit4] 2> 1354204 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[41]} 0 0 [junit4] 2> 1354204 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[42]} 0 0 [junit4] 2> 1354205 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[43]} 0 0 [junit4] 2> 1354206 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[44]} 0 1 [junit4] 2> 1354219 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[45]} 0 12 [junit4] 2> 1354220 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[46]} 0 0 [junit4] 2> 1354220 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[47]} 0 0 [junit4] 2> 1354221 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[48]} 0 0 [junit4] 2> 1354221 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[49]} 0 0 [junit4] 2> 1354221 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[50]} 0 0 [junit4] 2> 1354222 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[51]} 0 0 [junit4] 2> 1354222 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[52]} 0 0 [junit4] 2> 1354240 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[53]} 0 17 [junit4] 2> 1354241 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[54]} 0 0 [junit4] 2> 1354241 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[55]} 0 0 [junit4] 2> 1354242 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[56]} 0 0 [junit4] 2> 1354242 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[57]} 0 0 [junit4] 2> 1354242 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[58]} 0 0 [junit4] 2> 1354243 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[59]} 0 0 [junit4] 2> 1354243 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[60]} 0 0 [junit4] 2> 1354243 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[61]} 0 0 [junit4] 2> 1354257 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[62]} 0 1 [junit4] 2> 1354258 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[63]} 0 0 [junit4] 2> 1354259 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[64]} 0 0 [junit4] 2> 1354259 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[65]} 0 0 [junit4] 2> 1354259 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[66]} 0 0 [junit4] 2> 1354277 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[67]} 0 0 [junit4] 2> 1354278 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[68]} 0 0 [junit4] 2> 1354278 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[69]} 0 0 [junit4] 2> 1354278 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[70]} 0 0 [junit4] 2> 1354292 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[71]} 0 13 [junit4] 2> 1354293 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[72]} 0 0 [junit4] 2> 1354293 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[73]} 0 0 [junit4] 2> 1354294 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[74]} 0 0 [junit4] 2> 1354294 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[75]} 0 0 [junit4] 2> 1354294 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[76]} 0 0 [junit4] 2> 1354295 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[77]} 0 0 [junit4] 2> 1354295 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[78]} 0 0 [junit4] 2> 1354296 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[79]} 0 0 [junit4] 2> 1354314 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[80]} 0 18 [junit4] 2> 1354315 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[81]} 0 0 [junit4] 2> 1354315 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[82]} 0 0 [junit4] 2> 1354316 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[83]} 0 0 [junit4] 2> 1354316 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[84]} 0 0 [junit4] 2> 1354316 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[85]} 0 0 [junit4] 2> 1354329 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[86]} 0 0 [junit4] 2> 1354329 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[87]} 0 0 [junit4] 2> 1354330 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[88]} 0 0 [junit4] 2> 1354332 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[89]} 0 1 [junit4] 2> 1354349 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[90]} 0 0 [junit4] 2> 1354350 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[91]} 0 0 [junit4] 2> 1354350 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[92]} 0 0 [junit4] 2> 1354350 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[93]} 0 0 [junit4] 2> 1354351 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[94]} 0 0 [junit4] 2> 1354351 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[95]} 0 0 [junit4] 2> 1354351 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[96]} 0 0 [junit4] 2> 1354352 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[97]} 0 0 [junit4] 2> 1354366 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[98]} 0 13 [junit4] 2> 1354366 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[99]} 0 0 [junit4] 2> 1354367 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[100]} 0 0 [junit4] 2> 1354367 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[101]} 0 0 [junit4] 2> 1354367 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[102]} 0 0 [junit4] 2> 1354368 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[103]} 0 0 [junit4] 2> 1354368 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[104]} 0 0 [junit4] 2> 1354369 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[105]} 0 0 [junit4] 2> 1354369 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[106]} 0 0 [junit4] 2> 1354438 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[107]} 0 52 [junit4] 2> 1354438 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[108]} 0 0 [junit4] 2> 1354440 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[109]} 0 0 [junit4] 2> 1354440 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[110]} 0 0 [junit4] 2> 1354440 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[111]} 0 0 [junit4] 2> 1354441 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[112]} 0 0 [junit4] 2> 1354441 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[113]} 0 0 [junit4] 2> 1354442 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[114]} 0 0 [junit4] 2> 1354450 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[115]} 0 8 [junit4] 2> 1354452 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[116]} 0 1 [junit4] 2> 1354453 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[117]} 0 0 [junit4] 2> 1354453 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[118]} 0 0 [junit4] 2> 1354453 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[119]} 0 0 [junit4] 2> 1354454 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[120]} 0 0 [junit4] 2> 1354454 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[121]} 0 0 [junit4] 2> 1354467 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[122]} 0 12 [junit4] 2> 1354467 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[123]} 0 0 [junit4] 2> 1354467 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[124]} 0 0 [junit4] 2> 1354470 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[125]} 0 1 [junit4] 2> 1354470 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[126]} 0 0 [junit4] 2> 1354487 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[127]} 0 0 [junit4] 2> 1354488 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[128]} 0 0 [junit4] 2> 1354488 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[129]} 0 0 [junit4] 2> 1354488 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[130]} 0 0 [junit4] 2> 1354489 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[131]} 0 0 [junit4] 2> 1354489 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[132]} 0 0 [junit4] 2> 1354489 INFO (qtp156508328-6232) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[133]} 0 0 [junit4] 2> 1354504 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[134]} 0 14 [junit4] 2> 1354504 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[135]} 0 0 [junit4] 2> 1354505 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[136]} 0 0 [junit4] 2> 1354505 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[137]} 0 0 [junit4] 2> 1354505 INFO (qtp156508328-6229) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[138]} 0 0 [junit4] 2> 1354506 INFO (qtp156508328-6229) [...truncated too long message...] org.apache.solr.cloud.ZkController.getLeader(ZkController.java:1191) ~[java/:?] [junit4] 2> at org.apache.solr.cloud.ZkController.register(ZkController.java:1091) ~[java/:?] [junit4] 2> at org.apache.solr.cloud.ZkController$RegisterCoreAsync.call(ZkController.java:258) ~[java/:?] [junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266) ~[?:1.8.0_152] [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:192) ~[java/:?] [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_152] [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_152] [junit4] 2> at java.lang.Thread.run(Thread.java:748) [?:1.8.0_152] [junit4] 2> 21078148 ERROR (coreZkRegister-6028-thread-3) [n:127.0.0.1:33614_ c:collection2 s:shard7 r:core_node40 x:collection2_shard7_replica_n34] o.a.s.c.ZkController Error getting leader from zk [junit4] 2> org.apache.solr.common.SolrException: CoreContainer is closed [junit4] 2> at org.apache.solr.cloud.ZkController.getLeaderProps(ZkController.java:1268) ~[java/:?] [junit4] 2> at org.apache.solr.cloud.ZkController.getLeaderProps(ZkController.java:1235) ~[java/:?] [junit4] 2> at org.apache.solr.cloud.ZkController.getLeader(ZkController.java:1191) ~[java/:?] [junit4] 2> at org.apache.solr.cloud.ZkController.register(ZkController.java:1091) ~[java/:?] [junit4] 2> at org.apache.solr.cloud.ZkController$RegisterCoreAsync.call(ZkController.java:258) ~[java/:?] [junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266) ~[?:1.8.0_152] [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:192) ~[java/:?] [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_152] [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_152] [junit4] 2> at java.lang.Thread.run(Thread.java:748) [?:1.8.0_152] [junit4] 2> 21078150 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[A81891ADF121A048]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@293fea82{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 21078150 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[A81891ADF121A048]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@42dbe763{/,null,UNAVAILABLE} [junit4] 2> 21078150 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[A81891ADF121A048]) [ ] o.e.j.s.session Stopped scavenging [junit4] 2> 21078150 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[A81891ADF121A048]) [ ] o.a.s.c.ChaosMonkey monkey: stop jetty! 44859 [junit4] 2> 21078150 ERROR (TEST-FullSolrCloudDistribCmdsTest.test-seed#[A81891ADF121A048]) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes [junit4] 2> 21078151 INFO (TEST-FullSolrCloudDistribCmdsTest.test-seed#[A81891ADF121A048]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:33760 33760 [junit4] 2> 21078414 INFO (Thread-21498) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:33760 33760 [junit4] 2> 21078415 WARN (Thread-21498) [ ] o.a.s.c.ZkTestServer Watch limit violations: [junit4] 2> Maximum concurrent create/delete watches above limit: [junit4] 2> [junit4] 2> 33 /solr/aliases.json [junit4] 2> 16 /solr/collections/collection2/terms/shard3 [junit4] 2> 14 /solr/collections/collection1/terms/shard2 [junit4] 2> 13 /solr/collections/collection2/terms/shard7 [junit4] 2> 13 /solr/collections/collection2/terms/shard5 [junit4] 2> 13 /solr/collections/collection2/terms/shard6 [junit4] 2> 13 /solr/collections/collection2/terms/shard4 [junit4] 2> 13 /solr/collections/collection2/terms/shard1 [junit4] 2> 13 /solr/collections/collection2/terms/shard2 [junit4] 2> 13 /solr/configs/conf1 [junit4] 2> 12 /solr/collections/collection1/terms/shard3 [junit4] 2> 11 /solr/collections/collection1/terms/shard1 [junit4] 2> 10 /solr/security.json [junit4] 2> 3 /solr/collections/control_collection/terms/shard1 [junit4] 2> [junit4] 2> Maximum concurrent data watches above limit: [junit4] 2> [junit4] 2> 39 /solr/clusterprops.json [junit4] 2> 33 /solr/clusterstate.json [junit4] 2> 10 /solr/collections/collection2/state.json [junit4] 2> 6 /solr/collections/collection1/state.json [junit4] 2> 3 /solr/autoscaling.json [junit4] 2> 2 /solr/overseer_elect/election/72383185083629582-127.0.0.1:42679_-n_0000000002 [junit4] 2> [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2> [junit4] 2> 33 /solr/live_nodes [junit4] 2> 29 /solr/collections [junit4] 2> 3 /solr/overseer/queue [junit4] 2> 3 /solr/autoscaling/events/.scheduled_maintenance [junit4] 2> 3 /solr/overseer/collection-queue-work [junit4] 2> 3 /solr/overseer/queue-work [junit4] 2> [junit4] 2> NOTE: test params are: codec=CheapBastard, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@7ad61571), locale=ar-AE, timezone=Canada/Newfoundland [junit4] 2> NOTE: Linux 4.4.0-112-generic amd64/Oracle Corporation 1.8.0_152 (64-bit)/cpus=4,threads=1,free=145479864,total=509083648 [junit4] 2> NOTE: All tests run in this JVM: [TestMiniSolrCloudClusterSSL, FieldAnalysisRequestHandlerTest, TestConfigSetImmutable, TestIndexSearcher, DeleteStatusTest, OutputWriterTest, TestPolicyCloud, InfixSuggestersTest, RulesTest, CollectionsAPIDistributedZkTest, NumberUtilsTest, TestSchemaVersionResource, CollectionReloadTest, TestBulkSchemaConcurrent, SharedFSAutoReplicaFailoverTest, TestSolrFieldCacheBean, SpellCheckCollatorTest, TestDistributedStatsComponentCardinality, SolrPluginUtilsTest, TlogReplayBufferedWhileIndexingTest, TestDynamicLoading, TestWriterPerf, SimpleFacetsTest, TestInitParams, ChaosMonkeyNothingIsSafeTest, TestNumericTerms64, EchoParamsTest, RollingRestartTest, BinaryUpdateRequestHandlerTest, SolrJmxReporterTest, TestSubQueryTransformerDistrib, SolrCoreCheckLockOnStartupTest, HdfsNNFailoverTest, TestExceedMaxTermLength, TestLuceneMatchVersion, TestJavabinTupleStreamParser, HdfsRestartWhileUpdatingTest, TestRTimerTree, RAMDirectoryFactoryTest, SpatialHeatmapFacetsTest, AliasIntegrationTest, CoreAdminCreateDiscoverTest, TestDownShardTolerantSearch, DistributedFacetSimpleRefinementLongTailTest, TestDynamicFieldCollectionResource, TriggerSetPropertiesIntegrationTest, BufferStoreTest, MigrateRouteKeyTest, SimpleMLTQParserTest, SortSpecParsingTest, UninvertDocValuesMergePolicyTest, TestUseDocValuesAsStored, TestRemoteStreaming, TestPullReplica, TestConfig, CurrencyFieldTypeTest, DistributedFacetPivotSmallTest, BasicDistributedZkTest, BasicAuthStandaloneTest, SparseHLLTest, HdfsCollectionsAPIDistributedZkTest, StressHdfsTest, HighlighterConfigTest, AnalyticsQueryTest, HighlighterMaxOffsetTest, TestBlobHandler, TokenizerChainTest, TestSolrConfigHandlerCloud, TestSSLRandomization, BaseCdcrDistributedZkTest, TestPHPSerializedResponseWriter, BigEndianAscendingWordSerializerTest, TestNumericRangeQuery64, TestCSVResponseWriter, TestSolrQueryParser, TestRestManager, OpenExchangeRatesOrgProviderTest, XmlUpdateRequestHandlerTest, RequestLoggingTest, TestChildDocTransformer, TestPKIAuthenticationPlugin, TestLocalFSCloudBackupRestore, UUIDFieldTest, TestCrossCoreJoin, TestIndexingPerformance, TestSortByMinMaxFunction, ScheduledMaintenanceTriggerTest, BadIndexSchemaTest, ZkStateWriterTest, TestPhraseSuggestions, FullSolrCloudDistribCmdsTest, SuggesterWFSTTest] [junit4] 2> NOTE: download the large Jenkins line-docs file by running 'ant get-jenkins-line-docs' in the lucene directory. [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SuggesterWFSTTest -Dtests.seed=A81891ADF121A048 -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/test-data/enwiki.random.lines.txt -Dtests.locale=ar-AE -Dtests.timezone=Canada/Newfoundland -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 0.00s J0 | SuggesterWFSTTest (suite) <<< [junit4] > Throwable #1: java.lang.AssertionError [junit4] > at __randomizedtesting.SeedInfo.seed([A81891ADF121A048]:0) [junit4] > at java.lang.Thread.run(Thread.java:748) [junit4] Completed [756/795 (3!)] on J0 in 111.67s, 0 tests, 1 failure <<< FAILURES! [...truncated 173 lines...] [junit4] JVM J0: stdout was not empty, see: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/temp/junit4-J0-20180401_233050_7797947616340796968330.sysout [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] java.lang.OutOfMemoryError: Java heap space [junit4] Dumping heap to /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/heapdumps/java_pid27017.hprof ... [junit4] Heap dump file created [637229192 bytes in 17.567 secs] [junit4] <<< JVM J0: EOF ---- [...truncated 9265 lines...] BUILD FAILED /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/build.xml:651: The following error occurred while executing this line: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/build.xml:585: Some of the tests produced a heap dump, but did not fail. Maybe a suppressed OutOfMemoryError? Dumps created: * java_pid27017.hprof Total time: 774 minutes 35 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org