Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-5.x/674/

2 tests failed.
REGRESSION:  
org.apache.solr.handler.TestReplicationHandler.doTestReplicateAfterCoreReload

Error Message:
expected:<[{indexVersion=1415866945212,generation=2,filelist=[_711.fdt, 
_711.fdx, _711.fnm, _711.nvd, _711.nvm, _711.si, _711_Direct_0.doc, 
_711_Direct_0.tim, _711_Direct_0.tip, _e0j.fdt, _e0j.fdx, _e0j.fnm, _e0j.nvd, 
_e0j.nvm, _e0j.si, _e0j_Direct_0.doc, _e0j_Direct_0.tim, _e0j_Direct_0.tip, 
_ird.fdt, _ird.fdx, _ird.fnm, _ird.nvd, _ird.nvm, _ird.si, _ird_Direct_0.doc, 
_ird_Direct_0.tim, _ird_Direct_0.tip, _isw.fdt, _isw.fdx, _isw.fnm, _isw.nvd, 
_isw.nvm, _isw.si, _isw_Direct_0.doc, _isw_Direct_0.tim, _isw_Direct_0.tip, 
_isx.cfe, _isx.cfs, _isx.si, _isy.fdt, _isy.fdx, _isy.fnm, _isy.nvd, _isy.nvm, 
_isy.si, _isy_Direct_0.doc, _isy_Direct_0.tim, _isy_Direct_0.tip, _isz.fdt, 
_isz.fdx, _isz.fnm, _isz.nvd, _isz.nvm, _isz.si, _isz_Direct_0.doc, 
_isz_Direct_0.tim, _isz_Direct_0.tip, _it0.fdt, _it0.fdx, _it0.fnm, _it0.nvd, 
_it0.nvm, _it0.si, _it0_Direct_0.doc, _it0_Direct_0.tim, _it0_Direct_0.tip, 
_it1.fdt, _it1.fdx, _it1.fnm, _it1.nvd, _it1.nvm, _it1.si, _it1_Direct_0.doc, 
_it1_Direct_0.tim, _it1_Direct_0.tip, _it2.fdt, _it2.fdx, _it2.fnm, _it2.nvd, 
_it2.nvm, _it2.si, _it2_Direct_0.doc, _it2_Direct_0.tim, _it2_Direct_0.tip, 
_it3.fdt, _it3.fdx, _it3.fnm, _it3.nvd, _it3.nvm, _it3.si, _it3_Direct_0.doc, 
_it3_Direct_0.tim, _it3_Direct_0.tip, _it4.fdt, _it4.fdx, _it4.fnm, _it4.nvd, 
_it4.nvm, _it4.si, _it4_Direct_0.doc, _it4_Direct_0.tim, _it4_Direct_0.tip, 
_it5.fdt, _it5.fdx, _it5.fnm, _it5.nvd, _it5.nvm, _it5.si, _it5_Direct_0.doc, 
_it5_Direct_0.tim, _it5_Direct_0.tip, _iuq.fdt, _iuq.fdx, _iuq.fnm, _iuq.nvd, 
_iuq.nvm, _iuq.si, _iuq_Direct_0.doc, _iuq_Direct_0.tim, _iuq_Direct_0.tip, 
_iur.cfe, _iur.cfs, _iur.si, _ius.fdt, _ius.fdx, _ius.fnm, _ius.nvd, _ius.nvm, 
_ius.si, _ius_Direct_0.doc, _ius_Direct_0.tim, _ius_Direct_0.tip, _iut.fdt, 
_iut.fdx, _iut.fnm, _iut.nvd, _iut.nvm, _iut.si, _iut_Direct_0.doc, 
_iut_Direct_0.tim, _iut_Direct_0.tip, _iuu.fdt, _iuu.fdx, _iuu.fnm, _iuu.nvd, 
_iuu.nvm, _iuu.si, _iuu_Direct_0.doc, _iuu_Direct_0.tim, _iuu_Direct_0.tip, 
_iuv.fdt, _iuv.fdx, _iuv.fnm, _iuv.nvd, _iuv.nvm, _iuv.si, _iuv_Direct_0.doc, 
_iuv_Direct_0.tim, _iuv_Direct_0.tip, _iuw.fdt, _iuw.fdx, _iuw.fnm, _iuw.nvd, 
_iuw.nvm, _iuw.si, _iuw_Direct_0.doc, _iuw_Direct_0.tim, _iuw_Direct_0.tip, 
_iux.fdt, _iux.fdx, _iux.fnm, _iux.nvd, _iux.nvm, _iux.si, _iux_Direct_0.doc, 
_iux_Direct_0.tim, _iux_Direct_0.tip, _iuy.fdt, _iuy.fdx, _iuy.fnm, _iuy.nvd, 
_iuy.nvm, _iuy.si, _iuy_Direct_0.doc, _iuy_Direct_0.tim, _iuy_Direct_0.tip, 
_iuz.fdt, _iuz.fdx, _iuz.fnm, _iuz.nvd, _iuz.nvm, _iuz.si, _iuz_Direct_0.doc, 
_iuz_Direct_0.tim, _iuz_Direct_0.tip, segments_2]}]> but 
was:<[{indexVersion=1415866945212,generation=2,filelist=[_711.fdt, _711.fdx, 
_711.fnm, _711.nvd, _711.nvm, _711.si, _711_Direct_0.doc, _711_Direct_0.tim, 
_711_Direct_0.tip, _e0j.fdt, _e0j.fdx, _e0j.fnm, _e0j.nvd, _e0j.nvm, _e0j.si, 
_e0j_Direct_0.doc, _e0j_Direct_0.tim, _e0j_Direct_0.tip, _ird.fdt, _ird.fdx, 
_ird.fnm, _ird.nvd, _ird.nvm, _ird.si, _ird_Direct_0.doc, _ird_Direct_0.tim, 
_ird_Direct_0.tip, _isw.fdt, _isw.fdx, _isw.fnm, _isw.nvd, _isw.nvm, _isw.si, 
_isw_Direct_0.doc, _isw_Direct_0.tim, _isw_Direct_0.tip, _isx.cfe, _isx.cfs, 
_isx.si, _isy.fdt, _isy.fdx, _isy.fnm, _isy.nvd, _isy.nvm, _isy.si, 
_isy_Direct_0.doc, _isy_Direct_0.tim, _isy_Direct_0.tip, _isz.fdt, _isz.fdx, 
_isz.fnm, _isz.nvd, _isz.nvm, _isz.si, _isz_Direct_0.doc, _isz_Direct_0.tim, 
_isz_Direct_0.tip, _it0.fdt, _it0.fdx, _it0.fnm, _it0.nvd, _it0.nvm, _it0.si, 
_it0_Direct_0.doc, _it0_Direct_0.tim, _it0_Direct_0.tip, _it1.fdt, _it1.fdx, 
_it1.fnm, _it1.nvd, _it1.nvm, _it1.si, _it1_Direct_0.doc, _it1_Direct_0.tim, 
_it1_Direct_0.tip, _it2.fdt, _it2.fdx, _it2.fnm, _it2.nvd, _it2.nvm, _it2.si, 
_it2_Direct_0.doc, _it2_Direct_0.tim, _it2_Direct_0.tip, _it3.fdt, _it3.fdx, 
_it3.fnm, _it3.nvd, _it3.nvm, _it3.si, _it3_Direct_0.doc, _it3_Direct_0.tim, 
_it3_Direct_0.tip, _it4.fdt, _it4.fdx, _it4.fnm, _it4.nvd, _it4.nvm, _it4.si, 
_it4_Direct_0.doc, _it4_Direct_0.tim, _it4_Direct_0.tip, _it5.fdt, _it5.fdx, 
_it5.fnm, _it5.nvd, _it5.nvm, _it5.si, _it5_Direct_0.doc, _it5_Direct_0.tim, 
_it5_Direct_0.tip, _iuq.fdt, _iuq.fdx, _iuq.fnm, _iuq.nvd, _iuq.nvm, _iuq.si, 
_iuq_Direct_0.doc, _iuq_Direct_0.tim, _iuq_Direct_0.tip, _iur.cfe, _iur.cfs, 
_iur.si, _ius.fdt, _ius.fdx, _ius.fnm, _ius.nvd, _ius.nvm, _ius.si, 
_ius_Direct_0.doc, _ius_Direct_0.tim, _ius_Direct_0.tip, _iut.fdt, _iut.fdx, 
_iut.fnm, _iut.nvd, _iut.nvm, _iut.si, _iut_Direct_0.doc, _iut_Direct_0.tim, 
_iut_Direct_0.tip, _iuu.fdt, _iuu.fdx, _iuu.fnm, _iuu.nvd, _iuu.nvm, _iuu.si, 
_iuu_Direct_0.doc, _iuu_Direct_0.tim, _iuu_Direct_0.tip, _iuv.fdt, _iuv.fdx, 
_iuv.fnm, _iuv.nvd, _iuv.nvm, _iuv.si, _iuv_Direct_0.doc, _iuv_Direct_0.tim, 
_iuv_Direct_0.tip, _iuw.fdt, _iuw.fdx, _iuw.fnm, _iuw.nvd, _iuw.nvm, _iuw.si, 
_iuw_Direct_0.doc, _iuw_Direct_0.tim, _iuw_Direct_0.tip, _iux.fdt, _iux.fdx, 
_iux.fnm, _iux.nvd, _iux.nvm, _iux.si, _iux_Direct_0.doc, _iux_Direct_0.tim, 
_iux_Direct_0.tip, _iuy.fdt, _iuy.fdx, _iuy.fnm, _iuy.nvd, _iuy.nvm, _iuy.si, 
_iuy_Direct_0.doc, _iuy_Direct_0.tim, _iuy_Direct_0.tip, _iuz.fdt, _iuz.fdx, 
_iuz.fnm, _iuz.nvd, _iuz.nvm, _iuz.si, _iuz_Direct_0.doc, _iuz_Direct_0.tim, 
_iuz_Direct_0.tip, segments_2]}, 
{indexVersion=1415866945212,generation=3,filelist=[_711.fdt, _711.fdx, 
_711.fnm, _711.nvd, _711.nvm, _711.si, _711_Direct_0.doc, _711_Direct_0.tim, 
_711_Direct_0.tip, _e0j.fdt, _e0j.fdx, _e0j.fnm, _e0j.nvd, _e0j.nvm, _e0j.si, 
_e0j_Direct_0.doc, _e0j_Direct_0.tim, _e0j_Direct_0.tip, _iv0.fdt, _iv0.fdx, 
_iv0.fnm, _iv0.nvd, _iv0.nvm, _iv0.si, _iv0_Direct_0.doc, _iv0_Direct_0.tim, 
_iv0_Direct_0.tip, segments_3]}]>

Stack Trace:
java.lang.AssertionError: 
expected:<[{indexVersion=1415866945212,generation=2,filelist=[_711.fdt, 
_711.fdx, _711.fnm, _711.nvd, _711.nvm, _711.si, _711_Direct_0.doc, 
_711_Direct_0.tim, _711_Direct_0.tip, _e0j.fdt, _e0j.fdx, _e0j.fnm, _e0j.nvd, 
_e0j.nvm, _e0j.si, _e0j_Direct_0.doc, _e0j_Direct_0.tim, _e0j_Direct_0.tip, 
_ird.fdt, _ird.fdx, _ird.fnm, _ird.nvd, _ird.nvm, _ird.si, _ird_Direct_0.doc, 
_ird_Direct_0.tim, _ird_Direct_0.tip, _isw.fdt, _isw.fdx, _isw.fnm, _isw.nvd, 
_isw.nvm, _isw.si, _isw_Direct_0.doc, _isw_Direct_0.tim, _isw_Direct_0.tip, 
_isx.cfe, _isx.cfs, _isx.si, _isy.fdt, _isy.fdx, _isy.fnm, _isy.nvd, _isy.nvm, 
_isy.si, _isy_Direct_0.doc, _isy_Direct_0.tim, _isy_Direct_0.tip, _isz.fdt, 
_isz.fdx, _isz.fnm, _isz.nvd, _isz.nvm, _isz.si, _isz_Direct_0.doc, 
_isz_Direct_0.tim, _isz_Direct_0.tip, _it0.fdt, _it0.fdx, _it0.fnm, _it0.nvd, 
_it0.nvm, _it0.si, _it0_Direct_0.doc, _it0_Direct_0.tim, _it0_Direct_0.tip, 
_it1.fdt, _it1.fdx, _it1.fnm, _it1.nvd, _it1.nvm, _it1.si, _it1_Direct_0.doc, 
_it1_Direct_0.tim, _it1_Direct_0.tip, _it2.fdt, _it2.fdx, _it2.fnm, _it2.nvd, 
_it2.nvm, _it2.si, _it2_Direct_0.doc, _it2_Direct_0.tim, _it2_Direct_0.tip, 
_it3.fdt, _it3.fdx, _it3.fnm, _it3.nvd, _it3.nvm, _it3.si, _it3_Direct_0.doc, 
_it3_Direct_0.tim, _it3_Direct_0.tip, _it4.fdt, _it4.fdx, _it4.fnm, _it4.nvd, 
_it4.nvm, _it4.si, _it4_Direct_0.doc, _it4_Direct_0.tim, _it4_Direct_0.tip, 
_it5.fdt, _it5.fdx, _it5.fnm, _it5.nvd, _it5.nvm, _it5.si, _it5_Direct_0.doc, 
_it5_Direct_0.tim, _it5_Direct_0.tip, _iuq.fdt, _iuq.fdx, _iuq.fnm, _iuq.nvd, 
_iuq.nvm, _iuq.si, _iuq_Direct_0.doc, _iuq_Direct_0.tim, _iuq_Direct_0.tip, 
_iur.cfe, _iur.cfs, _iur.si, _ius.fdt, _ius.fdx, _ius.fnm, _ius.nvd, _ius.nvm, 
_ius.si, _ius_Direct_0.doc, _ius_Direct_0.tim, _ius_Direct_0.tip, _iut.fdt, 
_iut.fdx, _iut.fnm, _iut.nvd, _iut.nvm, _iut.si, _iut_Direct_0.doc, 
_iut_Direct_0.tim, _iut_Direct_0.tip, _iuu.fdt, _iuu.fdx, _iuu.fnm, _iuu.nvd, 
_iuu.nvm, _iuu.si, _iuu_Direct_0.doc, _iuu_Direct_0.tim, _iuu_Direct_0.tip, 
_iuv.fdt, _iuv.fdx, _iuv.fnm, _iuv.nvd, _iuv.nvm, _iuv.si, _iuv_Direct_0.doc, 
_iuv_Direct_0.tim, _iuv_Direct_0.tip, _iuw.fdt, _iuw.fdx, _iuw.fnm, _iuw.nvd, 
_iuw.nvm, _iuw.si, _iuw_Direct_0.doc, _iuw_Direct_0.tim, _iuw_Direct_0.tip, 
_iux.fdt, _iux.fdx, _iux.fnm, _iux.nvd, _iux.nvm, _iux.si, _iux_Direct_0.doc, 
_iux_Direct_0.tim, _iux_Direct_0.tip, _iuy.fdt, _iuy.fdx, _iuy.fnm, _iuy.nvd, 
_iuy.nvm, _iuy.si, _iuy_Direct_0.doc, _iuy_Direct_0.tim, _iuy_Direct_0.tip, 
_iuz.fdt, _iuz.fdx, _iuz.fnm, _iuz.nvd, _iuz.nvm, _iuz.si, _iuz_Direct_0.doc, 
_iuz_Direct_0.tim, _iuz_Direct_0.tip, segments_2]}]> but 
was:<[{indexVersion=1415866945212,generation=2,filelist=[_711.fdt, _711.fdx, 
_711.fnm, _711.nvd, _711.nvm, _711.si, _711_Direct_0.doc, _711_Direct_0.tim, 
_711_Direct_0.tip, _e0j.fdt, _e0j.fdx, _e0j.fnm, _e0j.nvd, _e0j.nvm, _e0j.si, 
_e0j_Direct_0.doc, _e0j_Direct_0.tim, _e0j_Direct_0.tip, _ird.fdt, _ird.fdx, 
_ird.fnm, _ird.nvd, _ird.nvm, _ird.si, _ird_Direct_0.doc, _ird_Direct_0.tim, 
_ird_Direct_0.tip, _isw.fdt, _isw.fdx, _isw.fnm, _isw.nvd, _isw.nvm, _isw.si, 
_isw_Direct_0.doc, _isw_Direct_0.tim, _isw_Direct_0.tip, _isx.cfe, _isx.cfs, 
_isx.si, _isy.fdt, _isy.fdx, _isy.fnm, _isy.nvd, _isy.nvm, _isy.si, 
_isy_Direct_0.doc, _isy_Direct_0.tim, _isy_Direct_0.tip, _isz.fdt, _isz.fdx, 
_isz.fnm, _isz.nvd, _isz.nvm, _isz.si, _isz_Direct_0.doc, _isz_Direct_0.tim, 
_isz_Direct_0.tip, _it0.fdt, _it0.fdx, _it0.fnm, _it0.nvd, _it0.nvm, _it0.si, 
_it0_Direct_0.doc, _it0_Direct_0.tim, _it0_Direct_0.tip, _it1.fdt, _it1.fdx, 
_it1.fnm, _it1.nvd, _it1.nvm, _it1.si, _it1_Direct_0.doc, _it1_Direct_0.tim, 
_it1_Direct_0.tip, _it2.fdt, _it2.fdx, _it2.fnm, _it2.nvd, _it2.nvm, _it2.si, 
_it2_Direct_0.doc, _it2_Direct_0.tim, _it2_Direct_0.tip, _it3.fdt, _it3.fdx, 
_it3.fnm, _it3.nvd, _it3.nvm, _it3.si, _it3_Direct_0.doc, _it3_Direct_0.tim, 
_it3_Direct_0.tip, _it4.fdt, _it4.fdx, _it4.fnm, _it4.nvd, _it4.nvm, _it4.si, 
_it4_Direct_0.doc, _it4_Direct_0.tim, _it4_Direct_0.tip, _it5.fdt, _it5.fdx, 
_it5.fnm, _it5.nvd, _it5.nvm, _it5.si, _it5_Direct_0.doc, _it5_Direct_0.tim, 
_it5_Direct_0.tip, _iuq.fdt, _iuq.fdx, _iuq.fnm, _iuq.nvd, _iuq.nvm, _iuq.si, 
_iuq_Direct_0.doc, _iuq_Direct_0.tim, _iuq_Direct_0.tip, _iur.cfe, _iur.cfs, 
_iur.si, _ius.fdt, _ius.fdx, _ius.fnm, _ius.nvd, _ius.nvm, _ius.si, 
_ius_Direct_0.doc, _ius_Direct_0.tim, _ius_Direct_0.tip, _iut.fdt, _iut.fdx, 
_iut.fnm, _iut.nvd, _iut.nvm, _iut.si, _iut_Direct_0.doc, _iut_Direct_0.tim, 
_iut_Direct_0.tip, _iuu.fdt, _iuu.fdx, _iuu.fnm, _iuu.nvd, _iuu.nvm, _iuu.si, 
_iuu_Direct_0.doc, _iuu_Direct_0.tim, _iuu_Direct_0.tip, _iuv.fdt, _iuv.fdx, 
_iuv.fnm, _iuv.nvd, _iuv.nvm, _iuv.si, _iuv_Direct_0.doc, _iuv_Direct_0.tim, 
_iuv_Direct_0.tip, _iuw.fdt, _iuw.fdx, _iuw.fnm, _iuw.nvd, _iuw.nvm, _iuw.si, 
_iuw_Direct_0.doc, _iuw_Direct_0.tim, _iuw_Direct_0.tip, _iux.fdt, _iux.fdx, 
_iux.fnm, _iux.nvd, _iux.nvm, _iux.si, _iux_Direct_0.doc, _iux_Direct_0.tim, 
_iux_Direct_0.tip, _iuy.fdt, _iuy.fdx, _iuy.fnm, _iuy.nvd, _iuy.nvm, _iuy.si, 
_iuy_Direct_0.doc, _iuy_Direct_0.tim, _iuy_Direct_0.tip, _iuz.fdt, _iuz.fdx, 
_iuz.fnm, _iuz.nvd, _iuz.nvm, _iuz.si, _iuz_Direct_0.doc, _iuz_Direct_0.tim, 
_iuz_Direct_0.tip, segments_2]}, 
{indexVersion=1415866945212,generation=3,filelist=[_711.fdt, _711.fdx, 
_711.fnm, _711.nvd, _711.nvm, _711.si, _711_Direct_0.doc, _711_Direct_0.tim, 
_711_Direct_0.tip, _e0j.fdt, _e0j.fdx, _e0j.fnm, _e0j.nvd, _e0j.nvm, _e0j.si, 
_e0j_Direct_0.doc, _e0j_Direct_0.tim, _e0j_Direct_0.tip, _iv0.fdt, _iv0.fdx, 
_iv0.fnm, _iv0.nvd, _iv0.nvm, _iv0.si, _iv0_Direct_0.doc, _iv0_Direct_0.tim, 
_iv0_Direct_0.tip, segments_3]}]>
        at 
__randomizedtesting.SeedInfo.seed([8E8D7A83BCE9C278:AB5A61B3CCA1CC7B]: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:1175)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:606)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        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:54)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at java.lang.Thread.run(Thread.java:745)


REGRESSION:  
org.apache.solr.update.SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds

Error Message:
1: soft wasn't fast enough

Stack Trace:
java.lang.AssertionError: 1: soft wasn't fast enough
        at 
__randomizedtesting.SeedInfo.seed([8E8D7A83BCE9C278:D298D4BA576B8300]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertNotNull(Assert.java:526)
        at 
org.apache.solr.update.SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds(SoftAutoCommitTest.java:316)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:606)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        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:54)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 11525 lines...]
   [junit4] Suite: org.apache.solr.update.SoftAutoCommitTest
   [junit4]   2> log4j:WARN No such property [conversionPattern] in 
org.apache.solr.util.SolrLogLayout.
   [junit4]   2> Creating dataDir: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-8E8D7A83BCE9C278-001/init-core-data-001
   [junit4]   2> 1798 T13 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl 
(true) and clientAuth (true)
   [junit4]   2> 1984 T13 oas.SolrTestCaseJ4.initCore ####initCore
   [junit4]   2> 2201 T13 oasc.SolrResourceLoader.<init> new SolrResourceLoader 
for directory: 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 2213 T13 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 2214 T13 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 2216 T13 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 4119 T13 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
5.0.0
   [junit4]   2> 4570 T13 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 4630 T13 oass.IndexSchema.readSchema Reading Solr Schema from 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/schema.xml
   [junit4]   2> 4783 T13 oass.IndexSchema.readSchema [null] Schema name=test
   [junit4]   2> 8100 T13 oass.OpenExchangeRatesOrgProvider.init Initialized 
with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 8183 T13 oass.IndexSchema.readSchema default search field in 
schema is text
   [junit4]   2> 8187 T13 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 9476 T13 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 9517 T13 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 9524 T13 oass.OpenExchangeRatesOrgProvider.reload Reloading 
exchange rates from open-exchange-rates.json
   [junit4]   2> 9555 T13 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 9556 T13 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 9557 T13 oass.OpenExchangeRatesOrgProvider.reload Reloading 
exchange rates from open-exchange-rates.json
   [junit4]   2> 9558 T13 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 9559 T13 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 9578 T13 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 9579 T13 oasc.SolrResourceLoader.locateSolrHome using system 
property solr.solr.home: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr
   [junit4]   2> 9579 T13 oasc.SolrResourceLoader.<init> new SolrResourceLoader 
for directory: 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/'
   [junit4]   2> 9880 T13 oasc.CoreContainer.<init> New CoreContainer 1912674492
   [junit4]   2> 9881 T13 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/]
   [junit4]   2> 10045 T13 oashc.HttpShardHandlerFactory.getParameter Setting 
socketTimeout to: 0
   [junit4]   2> 10046 T13 oashc.HttpShardHandlerFactory.getParameter Setting 
urlScheme to: null
   [junit4]   2> 10047 T13 oashc.HttpShardHandlerFactory.getParameter Setting 
connTimeout to: 0
   [junit4]   2> 10047 T13 oashc.HttpShardHandlerFactory.getParameter Setting 
maxConnectionsPerHost to: 20
   [junit4]   2> 10048 T13 oashc.HttpShardHandlerFactory.getParameter Setting 
maxConnections to: 10000
   [junit4]   2> 10049 T13 oashc.HttpShardHandlerFactory.getParameter Setting 
corePoolSize to: 0
   [junit4]   2> 10049 T13 oashc.HttpShardHandlerFactory.getParameter Setting 
maximumPoolSize to: 2147483647
   [junit4]   2> 10050 T13 oashc.HttpShardHandlerFactory.getParameter Setting 
maxThreadIdleTime to: 5
   [junit4]   2> 10050 T13 oashc.HttpShardHandlerFactory.getParameter Setting 
sizeOfQueue to: -1
   [junit4]   2> 10051 T13 oashc.HttpShardHandlerFactory.getParameter Setting 
fairnessPolicy to: false
   [junit4]   2> 11228 T13 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=30000&connTimeout=30000&retry=false
   [junit4]   2> 11262 T13 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 11270 T13 oasl.LogWatcher.newRegisteredLogWatcher Registering 
Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 11283 T13 oasc.CoreContainer.load Host Name: 
   [junit4]   2> 12017 T14 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 12020 T14 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 12021 T14 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 12023 T14 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 12298 T14 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
5.0.0
   [junit4]   2> 12373 T14 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 12375 T14 oass.IndexSchema.readSchema Reading Solr Schema from 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/schema.xml
   [junit4]   2> 12451 T14 oass.IndexSchema.readSchema [collection1] Schema 
name=test
   [junit4]   2> 12918 T14 oass.OpenExchangeRatesOrgProvider.init Initialized 
with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 12940 T14 oass.IndexSchema.readSchema default search field in 
schema is text
   [junit4]   2> 12944 T14 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 12975 T14 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 12983 T14 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 12989 T14 oass.OpenExchangeRatesOrgProvider.reload Reloading 
exchange rates from open-exchange-rates.json
   [junit4]   2> 12991 T14 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 12991 T14 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 12992 T14 oass.OpenExchangeRatesOrgProvider.reload Reloading 
exchange rates from open-exchange-rates.json
   [junit4]   2> 12993 T14 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 12994 T14 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 13002 T14 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from instancedir 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 13355 T14 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 13395 T14 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/,
 
dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-8E8D7A83BCE9C278-001/init-core-data-001/
   [junit4]   2> 13405 T14 oasc.JmxMonitoredMap.<init> No JMX servers found, 
not exposing Solr information with JMX.
   [junit4]   2> 13615 T14 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-8E8D7A83BCE9C278-001/init-core-data-001
   [junit4]   2> 13616 T14 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-8E8D7A83BCE9C278-001/init-core-data-001/index/
   [junit4]   2> 13617 T14 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-8E8D7A83BCE9C278-001/init-core-data-001/index'
 doesn't exist. Creating new index...
   [junit4]   2> 13618 T14 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-8E8D7A83BCE9C278-001/init-core-data-001/index
   [junit4]   2> 13623 T14 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=3, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 13960 T14 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@71c8fc50
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@422d228c)),segFN=segments_1,generation=1}
   [junit4]   2> 13969 T14 oasc.SolrDeletionPolicy.updateCommits newest commit 
generation = 1
   [junit4]   2> 14103 T14 oasc.SolrCore.initWriters created xml: 
solr.XMLResponseWriter
   [junit4]   2> 16745 T14 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 16967 T14 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 16968 T14 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 16969 T14 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 16970 T14 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 16971 T14 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 16972 T14 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 17032 T14 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 17032 T14 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 17286 T14 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 17287 T14 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 17287 T14 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 17344 T14 oasc.RequestHandlers.initHandlersFromConfig created 
/update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 17345 T14 oasc.RequestHandlers.initHandlersFromConfig created 
/update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 17345 T14 oasc.RequestHandlers.initHandlersFromConfig created 
/update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 17346 T14 oasc.RequestHandlers.initHandlersFromConfig adding 
lazy requestHandler: solr.ReplicationHandler
   [junit4]   2> 17354 T14 oasc.RequestHandlers.initHandlersFromConfig created 
/replication: solr.ReplicationHandler
   [junit4]   2> 17432 T14 oasc.RequestHandlers.initHandlersFromConfig created 
standard: solr.StandardRequestHandler
   [junit4]   2> 17491 T14 oasc.RequestHandlers.initHandlersFromConfig created 
/get: solr.RealTimeGetHandler
   [junit4]   2> 17665 T14 oasc.RequestHandlers.initHandlersFromConfig created 
dismax: solr.SearchHandler
   [junit4]   2> 17666 T14 oasc.RequestHandlers.initHandlersFromConfig created 
mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
   [junit4]   2> 17675 T14 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/: org.apache.solr.handler.admin.AdminHandlers
   [junit4]   2> 17755 T14 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/file: solr.admin.ShowFileRequestHandler
   [junit4]   2> 17832 T14 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/fileedit: solr.admin.EditFileRequestHandler
   [junit4]   2> 17833 T14 oasc.RequestHandlers.initHandlersFromConfig created 
defaults: solr.StandardRequestHandler
   [junit4]   2> 17833 T14 oasc.RequestHandlers.initHandlersFromConfig adding 
lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 17834 T14 oasc.RequestHandlers.initHandlersFromConfig created 
lazy: solr.StandardRequestHandler
   [junit4]   2> 17873 T14 oasc.RequestHandlers.initHandlersFromConfig created 
/update: solr.UpdateRequestHandler
   [junit4]   2> 17874 T14 oasc.RequestHandlers.initHandlersFromConfig created 
/terms: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 17875 T14 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 17875 T14 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 17876 T14 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 17876 T14 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 17877 T14 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 17877 T14 oasc.RequestHandlers.initHandlersFromConfig created 
mltrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 17878 T14 oasc.RequestHandlers.initHandlersFromConfig created 
tvrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 17910 T14 oasc.RequestHandlers.initHandlersFromConfig created 
/mlt: solr.MoreLikeThisHandler
   [junit4]   2> 17943 T14 oasc.RequestHandlers.initHandlersFromConfig created 
/debug/dump: solr.DumpRequestHandler
   [junit4]   2> 18142 T14 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 18169 T14 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 18171 T14 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 18173 T14 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 18179 T14 oasc.SolrCore.initDeprecatedSupport WARN 
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config 
to use the ShowFileRequestHandler.
   [junit4]   2> 18343 T14 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 18343 T14 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 18348 T14 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@2056ae83
   [junit4]   2> 18371 T14 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@71c8fc50
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@422d228c)),segFN=segments_1,generation=1}
   [junit4]   2> 18371 T14 oasc.SolrDeletionPolicy.updateCommits newest commit 
generation = 1
   [junit4]   2> 18525 T14 oass.SolrIndexSearcher.<init> Opening 
Searcher@4ee2dd22[collection1] main
   [junit4]   2> 18603 T14 oasr.RestManager.init Initializing RestManager with 
initArgs: 
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 18734 T14 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using InMemoryStorage
   [junit4]   2> 18734 T14 oasr.ManagedResource.reloadFromStorage WARN No 
stored data found for /rest/managed
   [junit4]   2> 18748 T14 oasr.ManagedResourceStorage$JsonStorage.store Saved 
JSON object to path _rest_managed.json using InMemoryStorage
   [junit4]   2> 18749 T14 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 18749 T14 oashc.SpellCheckComponent.inform Initializing spell 
checkers
   [junit4]   2> 19158 T14 oass.DirectSolrSpellChecker.init init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 19975 T14 oasc.CoreContainer.registerCore registering core: 
collection1
   [junit4]   2> 19975 T15 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@4ee2dd22[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 20019 T13 oas.SolrTestCaseJ4.initCore ####initCore end
   [junit4]   2> 20030 T13 oas.SolrTestCaseJ4.setUp ###Starting 
testSoftAndHardCommitMaxTimeRapidAdds
   [junit4]   2> 20031 T13 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 20033 T13 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 20034 T13 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 20035 T13 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 20254 T13 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
5.0.0
   [junit4]   2> 20341 T13 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 20343 T13 oass.IndexSchema.readSchema Reading Solr Schema from 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/schema.xml
   [junit4]   2> 20417 T13 oass.IndexSchema.readSchema [collection1] Schema 
name=test
   [junit4]   2> 20877 T13 oass.OpenExchangeRatesOrgProvider.init Initialized 
with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 20895 T13 oass.IndexSchema.readSchema default search field in 
schema is text
   [junit4]   2> 20898 T13 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 20925 T13 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 20932 T13 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 20937 T13 oass.OpenExchangeRatesOrgProvider.reload Reloading 
exchange rates from open-exchange-rates.json
   [junit4]   2> 20938 T13 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 20939 T13 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 20939 T13 oass.OpenExchangeRatesOrgProvider.reload Reloading 
exchange rates from open-exchange-rates.json
   [junit4]   2> 20940 T13 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 20941 T13 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 20941 T13 oasc.CoreContainer.reload Reloading SolrCore 
'collection1' using configuration from instancedir 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 20942 T13 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/,
 
dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-8E8D7A83BCE9C278-001/init-core-data-001/
   [junit4]   2> 20943 T13 oasc.JmxMonitoredMap.<init> No JMX servers found, 
not exposing Solr information with JMX.
   [junit4]   2> 20943 T13 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-8E8D7A83BCE9C278-001/init-core-data-001/index/
   [junit4]   2> 20944 T13 oasc.SolrCore.initWriters created xml: 
solr.XMLResponseWriter
   [junit4]   2> 20946 T13 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 20947 T13 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 20948 T13 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 20948 T13 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 20949 T13 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 20949 T13 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 20950 T13 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 20951 T13 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 20951 T13 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 20952 T13 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 20953 T13 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 20953 T13 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 20954 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 20954 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 20955 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 20955 T13 oasc.RequestHandlers.initHandlersFromConfig adding 
lazy requestHandler: solr.ReplicationHandler
   [junit4]   2> 20956 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/replication: solr.ReplicationHandler
   [junit4]   2> 20956 T13 oasc.RequestHandlers.initHandlersFromConfig created 
standard: solr.StandardRequestHandler
   [junit4]   2> 20957 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/get: solr.RealTimeGetHandler
   [junit4]   2> 20958 T13 oasc.RequestHandlers.initHandlersFromConfig created 
dismax: solr.SearchHandler
   [junit4]   2> 20958 T13 oasc.RequestHandlers.initHandlersFromConfig created 
mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
   [junit4]   2> 20959 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/: org.apache.solr.handler.admin.AdminHandlers
   [junit4]   2> 20960 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/file: solr.admin.ShowFileRequestHandler
   [junit4]   2> 20960 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/fileedit: solr.admin.EditFileRequestHandler
   [junit4]   2> 20961 T13 oasc.RequestHandlers.initHandlersFromConfig created 
defaults: solr.StandardRequestHandler
   [junit4]   2> 20961 T13 oasc.RequestHandlers.initHandlersFromConfig adding 
lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 20962 T13 oasc.RequestHandlers.initHandlersFromConfig created 
lazy: solr.StandardRequestHandler
   [junit4]   2> 20962 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/update: solr.UpdateRequestHandler
   [junit4]   2> 20963 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/terms: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 20963 T13 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 20964 T13 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 20964 T13 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 20965 T13 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 20966 T13 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 20967 T13 oasc.RequestHandlers.initHandlersFromConfig created 
mltrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 20967 T13 oasc.RequestHandlers.initHandlersFromConfig created 
tvrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 20968 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/mlt: solr.MoreLikeThisHandler
   [junit4]   2> 20968 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/debug/dump: solr.DumpRequestHandler
   [junit4]   2> 20970 T13 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 20973 T13 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 20975 T13 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 20977 T13 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 20979 T13 oasc.SolrCore.initDeprecatedSupport WARN 
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config 
to use the ShowFileRequestHandler.
   [junit4]   2> 20987 T13 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 20988 T13 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 20988 T13 oass.SolrIndexSearcher.<init> Opening 
Searcher@5474ef58[collection1] main
   [junit4]   2> 20989 T13 oasr.RestManager.init Initializing RestManager with 
initArgs: 
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 20990 T13 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using InMemoryStorage
   [junit4]   2> 20990 T13 oasr.ManagedResource.reloadFromStorage WARN No 
stored data found for /rest/managed
   [junit4]   2> 20991 T13 oasr.ManagedResourceStorage$JsonStorage.store Saved 
JSON object to path _rest_managed.json using InMemoryStorage
   [junit4]   2> 20991 T13 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 20992 T13 oashc.SpellCheckComponent.inform Initializing spell 
checkers
   [junit4]   2> 20996 T13 oass.DirectSolrSpellChecker.init init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 21013 T13 oasu.DefaultSolrCoreState.newIndexWriter Creating 
new IndexWriter...
   [junit4]   2> 21013 T17 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@5474ef58[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 21014 T13 oasu.DefaultSolrCoreState.newIndexWriter Waiting 
until IndexWriter is unused... core=collection1
   [junit4]   2> 21015 T13 oasu.DefaultSolrCoreState.newIndexWriter Closing old 
IndexWriter... core=collection1
   [junit4]   2> 21016 T13 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=19, maxMergeAtOnceExplicit=44, maxMergedSegmentMB=75.0380859375, 
floorSegmentMB=1.94140625, forceMergeDeletesPctAllowed=25.844980327716954, 
segmentsPerTier=29.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 21018 T13 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@71c8fc50
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@422d228c)),segFN=segments_1,generation=1}
   [junit4]   2> 21018 T13 oasc.SolrDeletionPolicy.updateCommits newest commit 
generation = 1
   [junit4]   2> 21019 T13 oasu.DefaultSolrCoreState.newIndexWriter New 
IndexWriter is ready to be used.
   [junit4]   2> 21020 T13 oass.SolrIndexSearcher.<init> Opening 
Searcher@3a089cc1[collection1] main
   [junit4]   2> 21027 T13 oasc.CoreContainer.registerCore replacing core: 
collection1
   [junit4]   2> 21028 T13 oasc.SolrCore.close [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1f4150bd
   [junit4]   2> 21028 T13 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=0,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
   [junit4]   2> 21029 T13 oasc.SolrCore.closeSearcher [collection1] Closing 
main searcher on request.
   [junit4]   2> 21050 T17 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@3a089cc1[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> ASYNC  NEW_CORE C0 name=collection1 
org.apache.solr.core.SolrCore@1e75a52d
   [junit4]   2> 22787 T13 C0 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[5000 (1484641447368982528)]} 0 1741
   [junit4]   2> 22912 T13 C0 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[5001 (1484641448561213440)]} 0 1
   [junit4]   2> 22916 T13 C0 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[5002 (1484641448565407744)]} 0 1
   [junit4]   2> 22919 T13 C0 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[5003 (1484641448568553472)]} 0 1
   [junit4]   2> 22922 T13 C0 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[5004 (1484641448571699200)]} 0 1
   [junit4]   2> 23269 T19 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 23925 T13 oas.SolrTestCaseJ4.tearDown ###Ending 
testSoftAndHardCommitMaxTimeRapidAdds
   [junit4]   2> 23968 T18 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> NOTE: download the large Jenkins line-docs file by running 
'ant get-jenkins-line-docs' in the lucene directory.
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=SoftAutoCommitTest 
-Dtests.method=testSoftAndHardCommitMaxTimeRapidAdds 
-Dtests.seed=8E8D7A83BCE9C278 -Dtests.multiplier=2 -Dtests.nightly=true 
-Dtests.slow=true 
-Dtests.linedocsfile=/home/jenkins/lucene-data/enwiki.random.lines.txt 
-Dtests.locale=vi_VN -Dtests.timezone=Europe/Samara -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] FAILURE 4.00s J0 | 
SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: 1: soft wasn't fast 
enough
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([8E8D7A83BCE9C278:D298D4BA576B8300]:0)
   [junit4]    >        at 
org.apache.solr.update.SoftAutoCommitTest.testSoftAndHardCommitMaxTimeRapidAdds(SoftAutoCommitTest.java:316)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 24032 T13 oas.SolrTestCaseJ4.setUp ###Starting 
testSoftAndHardCommitMaxTimeMixedAdds
   [junit4]   2> 24033 T13 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 24035 T13 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 24036 T13 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 24037 T13 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 24237 T13 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
5.0.0
   [junit4]   2> 24301 T13 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 24302 T13 oass.IndexSchema.readSchema Reading Solr Schema from 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/schema.xml
   [junit4]   2> 24387 T13 oass.IndexSchema.readSchema [collection1] Schema 
name=test
   [junit4]   2> 24389 T19 oass.SolrIndexSearcher.<init> Opening 
Searcher@53885c6b[collection1] main
   [junit4]   2> 24394 T19 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 24395 T17 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@53885c6b[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):C5)))}
   [junit4]   2> 24396 T18 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@71c8fc50
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@422d228c)),segFN=segments_1,generation=1}
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@71c8fc50
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@422d228c)),segFN=segments_2,generation=2}
   [junit4]   2> 24397 T18 oasc.SolrDeletionPolicy.updateCommits newest commit 
generation = 2
   [junit4]   2> 24398 T18 oasc.SolrCore.openNewSearcher SolrIndexSearcher has 
not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
   [junit4]   2> 24399 T18 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 24759 T13 oass.OpenExchangeRatesOrgProvider.init Initialized 
with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 24774 T13 oass.IndexSchema.readSchema default search field in 
schema is text
   [junit4]   2> 24777 T13 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 24801 T13 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 24811 T13 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 24815 T13 oass.OpenExchangeRatesOrgProvider.reload Reloading 
exchange rates from open-exchange-rates.json
   [junit4]   2> 24816 T13 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 24817 T13 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 24817 T13 oass.OpenExchangeRatesOrgProvider.reload Reloading 
exchange rates from open-exchange-rates.json
   [junit4]   2> 24818 T13 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 24819 T13 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 24819 T13 oasc.CoreContainer.reload Reloading SolrCore 
'collection1' using configuration from instancedir 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 24820 T13 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/,
 
dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-8E8D7A83BCE9C278-001/init-core-data-001/
   [junit4]   2> 24820 T13 oasc.JmxMonitoredMap.<init> No JMX servers found, 
not exposing Solr information with JMX.
   [junit4]   2> 24821 T13 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-8E8D7A83BCE9C278-001/init-core-data-001/index/
   [junit4]   2> 24822 T13 oasc.SolrCore.initWriters created xml: 
solr.XMLResponseWriter
   [junit4]   2> 24823 T13 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 24824 T13 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 24824 T13 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 24825 T13 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 24825 T13 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 24826 T13 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 24827 T13 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 24828 T13 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 24828 T13 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 24829 T13 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 24830 T13 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 24830 T13 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 24831 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 24831 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 24832 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 24832 T13 oasc.RequestHandlers.initHandlersFromConfig adding 
lazy requestHandler: solr.ReplicationHandler
   [junit4]   2> 24833 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/replication: solr.ReplicationHandler
   [junit4]   2> 24833 T13 oasc.RequestHandlers.initHandlersFromConfig created 
standard: solr.StandardRequestHandler
   [junit4]   2> 24834 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/get: solr.RealTimeGetHandler
   [junit4]   2> 24834 T13 oasc.RequestHandlers.initHandlersFromConfig created 
dismax: solr.SearchHandler
   [junit4]   2> 24835 T13 oasc.RequestHandlers.initHandlersFromConfig created 
mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
   [junit4]   2> 24835 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/: org.apache.solr.handler.admin.AdminHandlers
   [junit4]   2> 24836 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/file: solr.admin.ShowFileRequestHandler
   [junit4]   2> 24837 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/fileedit: solr.admin.EditFileRequestHandler
   [junit4]   2> 24837 T13 oasc.RequestHandlers.initHandlersFromConfig created 
defaults: solr.StandardRequestHandler
   [junit4]   2> 24837 T13 oasc.RequestHandlers.initHandlersFromConfig adding 
lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 24838 T13 oasc.RequestHandlers.initHandlersFromConfig created 
lazy: solr.StandardRequestHandler
   [junit4]   2> 24838 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/update: solr.UpdateRequestHandler
   [junit4]   2> 24839 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/terms: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 24839 T13 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 24840 T13 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 24840 T13 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 24841 T13 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 24841 T13 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 24842 T13 oasc.RequestHandlers.initHandlersFromConfig created 
mltrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 24842 T13 oasc.RequestHandlers.initHandlersFromConfig created 
tvrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 24843 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/mlt: solr.MoreLikeThisHandler
   [junit4]   2> 24843 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/debug/dump: solr.DumpRequestHandler
   [junit4]   2> 24860 T13 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 24862 T13 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 24864 T13 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 24866 T13 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 24867 T13 oasc.SolrCore.initDeprecatedSupport WARN 
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config 
to use the ShowFileRequestHandler.
   [junit4]   2> 24870 T13 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 24870 T13 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 24872 T13 oass.SolrIndexSearcher.<init> Opening 
Searcher@15946d47[collection1] main
   [junit4]   2> 24872 T13 oasr.RestManager.init Initializing RestManager with 
initArgs: 
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 24873 T13 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using InMemoryStorage
   [junit4]   2> 24873 T13 oasr.ManagedResource.reloadFromStorage WARN No 
stored data found for /rest/managed
   [junit4]   2> 24874 T13 oasr.ManagedResourceStorage$JsonStorage.store Saved 
JSON object to path _rest_managed.json using InMemoryStorage
   [junit4]   2> 24874 T13 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 24875 T13 oashc.SpellCheckComponent.inform Initializing spell 
checkers
   [junit4]   2> 24878 T13 oass.DirectSolrSpellChecker.init init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 24894 T13 oasu.DefaultSolrCoreState.newIndexWriter Creating 
new IndexWriter...
   [junit4]   2> 24894 T20 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@15946d47[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):C5)))}
   [junit4]   2> 24895 T13 oasu.DefaultSolrCoreState.newIndexWriter Waiting 
until IndexWriter is unused... core=collection1
   [junit4]   2> 24895 T13 oasu.DefaultSolrCoreState.newIndexWriter Closing old 
IndexWriter... core=collection1
   [junit4]   2> 24897 T13 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=41, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=0.693359375, 
floorSegmentMB=1.61328125, forceMergeDeletesPctAllowed=13.919043185460977, 
segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 24901 T13 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@71c8fc50
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@422d228c)),segFN=segments_2,generation=2}
   [junit4]   2> 24901 T13 oasc.SolrDeletionPolicy.updateCommits newest commit 
generation = 2
   [junit4]   2> 24902 T13 oasu.DefaultSolrCoreState.newIndexWriter New 
IndexWriter is ready to be used.
   [junit4]   2> 24909 T13 oass.SolrIndexSearcher.<init> Opening 
Searcher@59d9c141[collection1] main
   [junit4]   2> 24911 T13 oasc.CoreContainer.registerCore replacing core: 
collection1
   [junit4]   2> 24911 T20 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@59d9c141[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):C5)))}
   [junit4]   2> 24912 T13 oasc.SolrCore.close [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1e75a52d
   [junit4]   2> 24917 T13 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=2,autocommit maxTime=1200ms,autocommits=1,soft 
autocommit maxTime=500ms,soft 
autocommits=1,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=5,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=339,transaction_logs_total_number=1}
   [junit4]   2> 24918 T13 oasc.SolrCore.closeSearcher [collection1] Closing 
main searcher on request.
   [junit4]   2> ASYNC  NEW_CORE C1 name=collection1 
org.apache.solr.core.SolrCore@6ab1aae
   [junit4]   2> 24925 T13 C1 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[529 (1484641450667802624)]} 0 5
   [junit4]   2> 25426 T22 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 25610 T22 oass.SolrIndexSearcher.<init> Opening 
Searcher@a544ff1[collection1] main
   [junit4]   2> 25612 T22 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 25612 T20 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@a544ff1[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):C5)
 Uninverting(_1(5.0.0):C1)))}
   [junit4]   2> 25615 T13 C1 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[530 (1484641451394465792)]} 0 3
   [junit4]   2> 26116 T22 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 26126 T21 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 26131 T22 oass.SolrIndexSearcher.<init> Opening 
Searcher@434e25e1[collection1] main
   [junit4]   2> 26133 T22 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 26133 T20 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@434e25e1[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):C5)
 Uninverting(_1(5.0.0):C1) Uninverting(_2(5.0.0):C1)))}
   [junit4]   2> 26141 T21 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@71c8fc50
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@422d228c)),segFN=segments_2,generation=2}
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@71c8fc50
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@422d228c)),segFN=segments_3,generation=3}
   [junit4]   2> 26142 T21 oasc.SolrDeletionPolicy.updateCommits newest commit 
generation = 3
   [junit4]   2> 26143 T21 oasc.SolrCore.openNewSearcher SolrIndexSearcher has 
not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
   [junit4]   2> 26144 T21 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 29345 T13 oas.SolrTestCaseJ4.tearDown ###Ending 
testSoftAndHardCommitMaxTimeMixedAdds
   [junit4]   2> 29360 T13 oas.SolrTestCaseJ4.setUp ###Starting 
testSoftAndHardCommitMaxTimeDelete
   [junit4]   2> 29361 T13 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 29363 T13 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 29364 T13 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 29365 T13 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 29617 T13 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
5.0.0
   [junit4]   2> 29710 T13 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 29712 T13 oass.IndexSchema.readSchema Reading Solr Schema from 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/schema.xml
   [junit4]   2> 29770 T13 oass.IndexSchema.readSchema [collection1] Schema 
name=test
   [junit4]   2> 30342 T13 oass.OpenExchangeRatesOrgProvider.init Initialized 
with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 30368 T13 oass.IndexSchema.readSchema default search field in 
schema is text
   [junit4]   2> 30372 T13 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 30407 T13 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 30415 T13 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 30421 T13 oass.OpenExchangeRatesOrgProvider.reload Reloading 
exchange rates from open-exchange-rates.json
   [junit4]   2> 30423 T13 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 30424 T13 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 30424 T13 oass.OpenExchangeRatesOrgProvider.reload Reloading 
exchange rates from open-exchange-rates.json
   [junit4]   2> 30426 T13 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 30426 T13 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 30427 T13 oasc.CoreContainer.reload Reloading SolrCore 
'collection1' using configuration from instancedir 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 30428 T13 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/,
 
dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-8E8D7A83BCE9C278-001/init-core-data-001/
   [junit4]   2> 30429 T13 oasc.JmxMonitoredMap.<init> No JMX servers found, 
not exposing Solr information with JMX.
   [junit4]   2> 30429 T13 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-8E8D7A83BCE9C278-001/init-core-data-001/index/
   [junit4]   2> 30430 T13 oasc.SolrCore.initWriters created xml: 
solr.XMLResponseWriter
   [junit4]   2> 30433 T13 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 30434 T13 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 30434 T13 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 30435 T13 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 30436 T13 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 30436 T13 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 30437 T13 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 30438 T13 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 30439 T13 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 30440 T13 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 30441 T13 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 30442 T13 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 30443 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 30443 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 30444 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 30445 T13 oasc.RequestHandlers.initHandlersFromConfig adding 
lazy requestHandler: solr.ReplicationHandler
   [junit4]   2> 30445 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/replication: solr.ReplicationHandler
   [junit4]   2> 30446 T13 oasc.RequestHandlers.initHandlersFromConfig created 
standard: solr.StandardRequestHandler
   [junit4]   2> 30447 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/get: solr.RealTimeGetHandler
   [junit4]   2> 30447 T13 oasc.RequestHandlers.initHandlersFromConfig created 
dismax: solr.SearchHandler
   [junit4]   2> 30448 T13 oasc.RequestHandlers.initHandlersFromConfig created 
mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
   [junit4]   2> 30449 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/: org.apache.solr.handler.admin.AdminHandlers
   [junit4]   2> 30450 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/file: solr.admin.ShowFileRequestHandler
   [junit4]   2> 30451 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/admin/fileedit: solr.admin.EditFileRequestHandler
   [junit4]   2> 30451 T13 oasc.RequestHandlers.initHandlersFromConfig created 
defaults: solr.StandardRequestHandler
   [junit4]   2> 30452 T13 oasc.RequestHandlers.initHandlersFromConfig adding 
lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 30453 T13 oasc.RequestHandlers.initHandlersFromConfig created 
lazy: solr.StandardRequestHandler
   [junit4]   2> 30454 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/update: solr.UpdateRequestHandler
   [junit4]   2> 30454 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/terms: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 30455 T13 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 30456 T13 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 30457 T13 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 30457 T13 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 30458 T13 oasc.RequestHandlers.initHandlersFromConfig created 
spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 30459 T13 oasc.RequestHandlers.initHandlersFromConfig created 
mltrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 30460 T13 oasc.RequestHandlers.initHandlersFromConfig created 
tvrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 30460 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/mlt: solr.MoreLikeThisHandler
   [junit4]   2> 30461 T13 oasc.RequestHandlers.initHandlersFromConfig created 
/debug/dump: solr.DumpRequestHandler
   [junit4]   2> 30494 T13 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 30496 T13 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 30500 T13 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 30503 T13 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 30506 T13 oasc.SolrCore.initDeprecatedSupport WARN 
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config 
to use the ShowFileRequestHandler.
   [junit4]   2> 30509 T13 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 30510 T13 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 30512 T13 oass.SolrIndexSearcher.<init> Opening 
Searcher@2174650c[collection1] main
   [junit4]   2> 30513 T13 oasr.RestManager.init Initializing RestManager with 
initArgs: 
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 30514 T13 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using InMemoryStorage
   [junit4]   2> 30515 T13 oasr.ManagedResource.reloadFromStorage WARN No 
stored data found for /rest/managed
   [junit4]   2> 30515 T13 oasr.ManagedResourceStorage$JsonStorage.store Saved 
JSON object to path _rest_managed.json using InMemoryStorage
   [junit4]   2> 30516 T13 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 30516 T13 oashc.SpellCheckComponent.inform Initializing spell 
checkers
   [junit4]   2> 30522 T13 oass.DirectSolrSpellChecker.init init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 30547 T13 oasu.DefaultSolrCoreState.newIndexWriter Creating 
new IndexWriter...
   [junit4]   2> 30547 T23 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@2174650c[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):C5)
 Uninverting(_1(5.0.0):C1) Uninverting(_2(5.0.0):C1)))}
   [junit4]   2> 30548 T13 oasu.DefaultSolrCoreState.newIndexWriter Waiting 
until IndexWriter is unused... core=collection1
   [junit4]   2> 30549 T13 oasu.DefaultSolrCoreState.newIndexWriter Closing old 
IndexWriter... core=collection1
   [junit4]   2> 30551 T13 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=23, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 30562 T13 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@71c8fc50
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@422d228c)),segFN=segments_3,generation=3}
   [junit4]   2> 30563 T13 oasc.SolrDeletionPolicy.updateCommits newest commit 
generation = 3
   [junit4]   2> 30564 T13 oasu.DefaultSolrCoreState.newIndexWriter New 
IndexWriter is ready to be used.
   [junit4]   2> 30682 T13 oass.SolrIndexSearcher.<init> Opening 
Searcher@61f133ea[collection1] main
   [junit4]   2> 30684 T13 oasc.CoreContainer.registerCore replacing core: 
collection1
   [junit4]   2> 30684 T23 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@61f133ea[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):C5)
 Uninverting(_1(5.0.0):C1) Uninverting(_2(5.0.0):C1)))}
   [junit4]   2> 30684 T13 oasc.SolrCore.close [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@6ab1aae
   [junit4]   2> 30686 T13 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=3,autocommit maxTime=1200ms,autocommits=1,soft 
autocommit maxTime=500ms,soft 
autocommits=2,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=2,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=544,transaction_logs_total_number=2}
   [junit4]   2> 30687 T13 oasc.SolrCore.closeSearcher [collection1] Closing 
main searcher on request.
   [junit4]   2> ASYNC  NEW_CORE C2 name=collection1 
org.apache.solr.core.SolrCore@57a54666
   [junit4]   2> 30696 T13 C2 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[529 (1484641456718086144)]} 0 6
   [junit4]   2> 30705 T13 C2 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 30755 T13 C2 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@71c8fc50
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@422d228c)),segFN=segments_3,generation=3}
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@71c8fc50
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@422d228c)),segFN=segments_4,generation=4}
   [junit4]   2> 30756 T13 C2 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 4
   [junit4]   2> 30762 T13 C2 oass.SolrIndexSearcher.<init> Opening 
Searcher@dd2cc4a[collection1] main
   [junit4]   2> 30763 T13 C2 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 30764 T23 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@dd2cc4a[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):C5)
 Uninverting(_2(5.0.0):C1) Uninverting(_3(5.0.0):C1)))}
   [junit4]   2> 30766 T13 C2 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {commit=} 0 62
   [junit4]   2> 30772 T13 C2 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {delete=[529 (-1484641456801972224)]} 0 3
   [junit4]   2> 31274 T25 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 31288 T25 oass.SolrIndexSearcher.<init> Opening 
Searcher@25de587d[collection1] main
   [junit4]   2> 31289 T25 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 31289 T23 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@25de587d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):C5)
 Uninverting(_2(5.0.0):C1)))}
   [junit4]   2> 31293 T13 C2 oasup.LogUpdateProcessor.finish [collection1] 
webapp=null path=null params={} {add=[550 (1484641457347231744)]} 0 4
   [junit4]   2> 31793 T25 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 31806 T25 oass.SolrIndexSearcher.<init> Opening 
Searcher@55f805f6[collection1] main
   [junit4]   2> 31807 T25 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 31807 T23 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@55f805f6[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):C5)
 Uninverting(_2(5.0.0):C1) Uninverting(_4(5.0.0):C1)))}
   [junit4]   2> 31974 T24 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 31977 T24 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@71c8fc50
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@422d228c)),segFN=segments_4,generation=4}
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@71c8fc50
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@422d228c)),segFN=segments_5,generation=5}
   [junit4]   2> 31977 T24 oasc.SolrDeletionPolicy.updateCommits newest commit 
generation = 5
   [junit4]   2> 31978 T24 oasc.SolrCore.openNewSearcher SolrIndexSearcher has 
not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
   [junit4]   2> 31979 T24 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 33978 T13 oas.SolrTestCaseJ4.tearDown ###Ending 
testSoftAndHardCommitMaxTimeDelete
   [junit4]   2> 33982 T13 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> 33983 T13 oasc.CoreContainer.shutdown Shutting down 
CoreContainer instance=1912674492
   [junit4]   2> 33983 T13 oasc.SolrCore.close [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@57a54666
   [junit4]   2> 33984 T13 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=4,autocommit maxTime=1200ms,autocommits=1,soft 
autocommit maxTime=500ms,soft 
autocommits=2,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=2,cumulative_deletesById=1,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=838,transaction_logs_total_number=4}
   [junit4]   2> 33984 T13 oasu.SolrCoreState.decrefSolrCoreState Closing 
SolrCoreState
   [junit4]   2> 33985 T13 oasu.DefaultSolrCoreState.closeIndexWriter 
SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 33985 T13 oasu.DefaultSolrCoreState.closeIndexWriter closing 
IndexWriter with IndexWriterCloser
   [junit4]   2> 33987 T13 oasc.SolrCore.closeSearcher [collection1] Closing 
main searcher on request.
   [junit4]   2> 33990 T13 oasc.CachingDirectoryFactory.close Closing 
MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 33991 T13 oasc.CachingDirectoryFactory.closeCacheValue looking 
to close 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-8E8D7A83BCE9C278-001/init-core-data-001/index
 
[CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-8E8D7A83BCE9C278-001/init-core-data-001/index;done=false>>]
   [junit4]   2> 33991 T13 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.update.SoftAutoCommitTest-8E8D7A83BCE9C278-001/init-core-data-001/index
   [junit4]   2> 33992 T13 oasc.CachingDirectoryFac

[...truncated too long message...]

handler.TestReplicationHandler-8E8D7A83BCE9C278-001/solr-instance-003/collection1/data
   [junit4]   2> 3364180 T513904 oejsh.ContextHandler.doStop stopped 
o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 3369180 T513904 oas.SolrTestCaseJ4.tearDown ###Ending 
doTestRepeater
   [junit4]   2> 3369181 T513904 oasc.CoreContainer.shutdown Shutting down 
CoreContainer instance=894345753
   [junit4]   2> 3369184 T513904 oasc.SolrCore.close [collection1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@2c53969d
   [junit4]   2> 3369184 T513904 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=2,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=6,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
   [junit4]   2> 3369185 T513904 oasu.SolrCoreState.decrefSolrCoreState Closing 
SolrCoreState
   [junit4]   2> 3369185 T513904 oasu.DefaultSolrCoreState.closeIndexWriter 
SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 3369186 T513904 oasu.DefaultSolrCoreState.closeIndexWriter 
closing IndexWriter with IndexWriterCloser
   [junit4]   2> 3369187 T513904 oasc.SolrCore.closeSearcher [collection1] 
Closing main searcher on request.
   [junit4]   2> 3369188 T513904 oasc.CachingDirectoryFactory.close Closing 
MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 3369188 T513904 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler-8E8D7A83BCE9C278-001/solr-instance-001/collection1/data/index
 
[CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler-8E8D7A83BCE9C278-001/solr-instance-001/collection1/data/index;done=false>>]
   [junit4]   2> 3369188 T513904 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler-8E8D7A83BCE9C278-001/solr-instance-001/collection1/data/index
   [junit4]   2> 3369189 T513904 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler-8E8D7A83BCE9C278-001/solr-instance-001/collection1/data
 
[CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler-8E8D7A83BCE9C278-001/solr-instance-001/collection1/data;done=false>>]
   [junit4]   2> 3369189 T513904 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler-8E8D7A83BCE9C278-001/solr-instance-001/collection1/data
   [junit4]   2> 3369190 T513904 oejsh.ContextHandler.doStop stopped 
o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 3374186 T513904 oasc.CoreContainer.shutdown Shutting down 
CoreContainer instance=919617065
   [junit4]   2> 3374188 T513904 oasc.SolrCore.close [collection1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@2d36b619
   [junit4]   2> 3374188 T513904 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=0,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
   [junit4]   2> 3374189 T513904 oasu.SolrCoreState.decrefSolrCoreState Closing 
SolrCoreState
   [junit4]   2> 3374189 T513904 oasu.DefaultSolrCoreState.closeIndexWriter 
SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 3374190 T513904 oasu.DefaultSolrCoreState.closeIndexWriter 
closing IndexWriter with IndexWriterCloser
   [junit4]   2> 3374191 T513904 oasc.SolrCore.closeSearcher [collection1] 
Closing main searcher on request.
   [junit4]   2> 3374192 T513904 oasc.CachingDirectoryFactory.close Closing 
MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 3374192 T513904 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler-8E8D7A83BCE9C278-001/solr-instance-002/collection1/data/index
 
[CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler-8E8D7A83BCE9C278-001/solr-instance-002/collection1/data/index;done=false>>]
   [junit4]   2> 3374193 T513904 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler-8E8D7A83BCE9C278-001/solr-instance-002/collection1/data/index
   [junit4]   2> 3374193 T513904 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler-8E8D7A83BCE9C278-001/solr-instance-002/collection1/data
 
[CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler-8E8D7A83BCE9C278-001/solr-instance-002/collection1/data;done=false>>]
   [junit4]   2> 3374194 T513904 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler-8E8D7A83BCE9C278-001/solr-instance-002/collection1/data
   [junit4]   2> 3374194 T513904 oejsh.ContextHandler.doStop stopped 
o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 3379200 T513904 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler-8E8D7A83BCE9C278-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene50): 
{newname=PostingsFormat(name=Direct), id=PostingsFormat(name=Direct), 
name=PostingsFormat(name=Direct)}, docValues:{}, 
sim=RandomSimilarityProvider(queryNorm=false,coord=yes): {}, locale=es, 
timezone=Africa/Addis_Ababa
   [junit4]   2> NOTE: FreeBSD 9.1-RELEASE-p3 amd64/Oracle Corporation 1.7.0_65 
(64-bit)/cpus=16,threads=1,free=125884752,total=476053504
   [junit4]   2> NOTE: All tests run in this JVM: [ExternalFileFieldSortTest, 
TestCursorMarkWithoutUniqueKey, TestZkChroot, TestStressVersions, 
DocumentBuilderTest, JSONWriterTest, SolrCoreTest, 
TestPartialUpdateDeduplication, TestCollationField, SuggesterFSTTest, 
TestCollectionAPI, MigrateRouteKeyTest, ChaosMonkeySafeLeaderTest, 
CurrencyFieldOpenExchangeTest, TestBlendedInfixSuggestions, SortByFunctionTest, 
BasicZkTest, HdfsWriteToMultipleCollectionsTest, TestTolerantSearch, 
TestConfigSets, AutoCommitTest, RequiredFieldsTest, 
DistributedDebugComponentTest, TestReload, DirectUpdateHandlerOptimizeTest, 
MultiThreadedOCPTest, PreAnalyzedUpdateProcessorTest, DisMaxRequestHandlerTest, 
TestCloudInspectUtil, DebugComponentTest, TestLFUCache, TestComponentsName, 
TestConfig, DirectSolrSpellCheckerTest, ZkControllerTest, 
SystemInfoHandlerTest, URLClassifyProcessorTest, TestSystemIdResolver, 
EnumFieldTest, UpdateParamsTest, SolrCoreCheckLockOnStartupTest, 
DistributedFacetPivotSmallTest, SolrRequestParserTest, 
TestLMDirichletSimilarityFactory, AssignTest, 
SignatureUpdateProcessorFactoryTest, TestReloadAndDeleteDocs, 
OverriddenZkACLAndCredentialsProvidersTest, ExitableDirectoryReaderTest, 
TestHighFrequencyDictionaryFactory, OpenCloseCoreStressTest, 
TestAtomicUpdateErrorCases, PreAnalyzedFieldTest, SpatialFilterTest, 
MBeansHandlerTest, OverseerTest, LeaderElectionIntegrationTest, 
ShardRoutingTest, TestReplicationHandler]
   [junit4] Completed on J1 in 1439.22s, 14 tests, 1 failure <<< FAILURES!

[...truncated 196 lines...]
BUILD FAILED
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:532:
 The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:473:
 The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:61:
 The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/extra-targets.xml:39:
 The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build.xml:189:
 The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/common-build.xml:508:
 The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/lucene/common-build.xml:1359:
 The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/lucene/common-build.xml:966:
 There were test failures: 444 suites, 1818 tests, 2 failures, 54 ignored (9 
assumptions)

Total time: 265 minutes 49 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Sending artifact delta relative to Lucene-Solr-NightlyTests-5.x #667
Archived 5 artifacts
Archive block size is 32768
Received 0 blocks and 1221186698 bytes
Compression is 0.0%
Took 3 min 39 sec
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure


---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to