lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Apache Jenkins Server <jenk...@builds.apache.org>
Subject [JENKINS] Lucene-Solr-NightlyTests-trunk - Build # 931 - Still Failing
Date Thu, 11 Feb 2016 16:41:30 GMT
Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-trunk/931/

1 tests failed.
FAILED:  org.apache.solr.handler.TestReplicationHandler.doTestReplicateAfterCoreReload

Error Message:
expected:<[{indexVersion=1455206967924,generation=2,filelist=[_hak.fdt, _hak.fdx, _hak.fnm, _hak.nvd, _hak.nvm, _hak.si, _hak_Memory_0.ram, _hch.fdt, _hch.fdx, _hch.fnm, _hch.nvd, _hch.nvm, _hch.si, _hch_Memory_0.ram, _hcq.fdt, _hcq.fdx, _hcq.fnm, _hcq.nvd, _hcq.nvm, _hcq.si, _hcq_Memory_0.ram, _hcs.cfe, _hcs.cfs, _hcs.si, _hct.fdt, _hct.fdx, _hct.fnm, _hct.nvd, _hct.nvm, _hct.si, _hct_Memory_0.ram, _hcw.fdt, _hcw.fdx, _hcw.fnm, _hcw.nvd, _hcw.nvm, _hcw.si, _hcw_Memory_0.ram, _hcz.fdt, _hcz.fdx, _hcz.fnm, _hcz.nvd, _hcz.nvm, _hcz.si, _hcz_Memory_0.ram, _hd0.fdt, _hd0.fdx, _hd0.fnm, _hd0.nvd, _hd0.nvm, _hd0.si, _hd0_Memory_0.ram, _hd1.cfe, _hd1.cfs, _hd1.si, _hd2.fdt, _hd2.fdx, _hd2.fnm, _hd2.nvd, _hd2.nvm, _hd2.si, _hd2_Memory_0.ram, _hd3.fdt, _hd3.fdx, _hd3.fnm, _hd3.nvd, _hd3.nvm, _hd3.si, _hd3_Memory_0.ram, _hd5.fdt, _hd5.fdx, _hd5.fnm, _hd5.nvd, _hd5.nvm, _hd5.si, _hd5_Memory_0.ram, _hd7.fdt, _hd7.fdx, _hd7.fnm, _hd7.nvd, _hd7.nvm, _hd7.si, _hd7_Memory_0.ram, _hd8.fdt, _hd8.fdx, _hd8.fnm, _hd8.nvd, _hd8.nvm, _hd8.si, _hd8_Memory_0.ram, _hd9.cfe, _hd9.cfs, _hd9.si, _hdb.fdt, _hdb.fdx, _hdb.fnm, _hdb.nvd, _hdb.nvm, _hdb.si, _hdb_Memory_0.ram, _hdc.fdt, _hdc.fdx, _hdc.fnm, _hdc.nvd, _hdc.nvm, _hdc.si, _hdc_Memory_0.ram, _hdf.fdt, _hdf.fdx, _hdf.fnm, _hdf.nvd, _hdf.nvm, _hdf.si, _hdf_Memory_0.ram, _hdg.fdt, _hdg.fdx, _hdg.fnm, _hdg.nvd, _hdg.nvm, _hdg.si, _hdg_Memory_0.ram, _hdh.fdt, _hdh.fdx, _hdh.fnm, _hdh.nvd, _hdh.nvm, _hdh.si, _hdh_Memory_0.ram, _hdi.fdt, _hdi.fdx, _hdi.fnm, _hdi.nvd, _hdi.nvm, _hdi.si, _hdi_Memory_0.ram, _hdj.fdt, _hdj.fdx, _hdj.fnm, _hdj.nvd, _hdj.nvm, _hdj.si, _hdj_Memory_0.ram, _hek.cfe, _hek.cfs, _hek.si, _hep.fdt, _hep.fdx, _hep.fnm, _hep.nvd, _hep.nvm, _hep.si, _hep_Memory_0.ram, _heq.cfe, _heq.cfs, _heq.si, _her.fdt, _her.fdx, _her.fnm, _her.nvd, _her.nvm, _her.si, _her_Memory_0.ram, _hes.fdt, _hes.fdx, _hes.fnm, _hes.nvd, _hes.nvm, _hes.si, _hes_Memory_0.ram, _het.fdt, _het.fdx, _het.fnm, _het.nvd, _het.nvm, _het.si, _het_Memory_0.ram, _heu.fdt, _heu.fdx, _heu.fnm, _heu.nvd, _heu.nvm, _heu.si, _heu_Memory_0.ram, _hev.fdt, _hev.fdx, _hev.fnm, _hev.nvd, _hev.nvm, _hev.si, _hev_Memory_0.ram, segments_2]}]> but was:<[{indexVersion=1455206967924,generation=2,filelist=[_hak.fdt, _hak.fdx, _hak.fnm, _hak.nvd, _hak.nvm, _hak.si, _hak_Memory_0.ram, _hch.fdt, _hch.fdx, _hch.fnm, _hch.nvd, _hch.nvm, _hch.si, _hch_Memory_0.ram, _hcq.fdt, _hcq.fdx, _hcq.fnm, _hcq.nvd, _hcq.nvm, _hcq.si, _hcq_Memory_0.ram, _hcs.cfe, _hcs.cfs, _hcs.si, _hct.fdt, _hct.fdx, _hct.fnm, _hct.nvd, _hct.nvm, _hct.si, _hct_Memory_0.ram, _hcw.fdt, _hcw.fdx, _hcw.fnm, _hcw.nvd, _hcw.nvm, _hcw.si, _hcw_Memory_0.ram, _hcz.fdt, _hcz.fdx, _hcz.fnm, _hcz.nvd, _hcz.nvm, _hcz.si, _hcz_Memory_0.ram, _hd0.fdt, _hd0.fdx, _hd0.fnm, _hd0.nvd, _hd0.nvm, _hd0.si, _hd0_Memory_0.ram, _hd1.cfe, _hd1.cfs, _hd1.si, _hd2.fdt, _hd2.fdx, _hd2.fnm, _hd2.nvd, _hd2.nvm, _hd2.si, _hd2_Memory_0.ram, _hd3.fdt, _hd3.fdx, _hd3.fnm, _hd3.nvd, _hd3.nvm, _hd3.si, _hd3_Memory_0.ram, _hd5.fdt, _hd5.fdx, _hd5.fnm, _hd5.nvd, _hd5.nvm, _hd5.si, _hd5_Memory_0.ram, _hd7.fdt, _hd7.fdx, _hd7.fnm, _hd7.nvd, _hd7.nvm, _hd7.si, _hd7_Memory_0.ram, _hd8.fdt, _hd8.fdx, _hd8.fnm, _hd8.nvd, _hd8.nvm, _hd8.si, _hd8_Memory_0.ram, _hd9.cfe, _hd9.cfs, _hd9.si, _hdb.fdt, _hdb.fdx, _hdb.fnm, _hdb.nvd, _hdb.nvm, _hdb.si, _hdb_Memory_0.ram, _hdc.fdt, _hdc.fdx, _hdc.fnm, _hdc.nvd, _hdc.nvm, _hdc.si, _hdc_Memory_0.ram, _hdf.fdt, _hdf.fdx, _hdf.fnm, _hdf.nvd, _hdf.nvm, _hdf.si, _hdf_Memory_0.ram, _hdg.fdt, _hdg.fdx, _hdg.fnm, _hdg.nvd, _hdg.nvm, _hdg.si, _hdg_Memory_0.ram, _hdh.fdt, _hdh.fdx, _hdh.fnm, _hdh.nvd, _hdh.nvm, _hdh.si, _hdh_Memory_0.ram, _hdi.fdt, _hdi.fdx, _hdi.fnm, _hdi.nvd, _hdi.nvm, _hdi.si, _hdi_Memory_0.ram, _hdj.fdt, _hdj.fdx, _hdj.fnm, _hdj.nvd, _hdj.nvm, _hdj.si, _hdj_Memory_0.ram, _hek.cfe, _hek.cfs, _hek.si, _hep.fdt, _hep.fdx, _hep.fnm, _hep.nvd, _hep.nvm, _hep.si, _hep_Memory_0.ram, _heq.cfe, _heq.cfs, _heq.si, _her.fdt, _her.fdx, _her.fnm, _her.nvd, _her.nvm, _her.si, _her_Memory_0.ram, _hes.fdt, _hes.fdx, _hes.fnm, _hes.nvd, _hes.nvm, _hes.si, _hes_Memory_0.ram, _het.fdt, _het.fdx, _het.fnm, _het.nvd, _het.nvm, _het.si, _het_Memory_0.ram, _heu.fdt, _heu.fdx, _heu.fnm, _heu.nvd, _heu.nvm, _heu.si, _heu_Memory_0.ram, _hev.fdt, _hev.fdx, _hev.fnm, _hev.nvd, _hev.nvm, _hev.si, _hev_Memory_0.ram, segments_2]}, {indexVersion=1455206967924,generation=3,filelist=[_hdm.fdt, _hdm.fdx, _hdm.fnm, _hdm.nvd, _hdm.nvm, _hdm.si, _hdm_Memory_0.ram, _hek.cfe, _hek.cfs, _hek.si, _heu.fdt, _heu.fdx, _heu.fnm, _heu.nvd, _heu.nvm, _heu.si, _heu_Memory_0.ram, _hev.fdt, _hev.fdx, _hev.fnm, _hev.nvd, _hev.nvm, _hev.si, _hev_Memory_0.ram, _hew.cfe, _hew.cfs, _hew.si, segments_3]}]>

Stack Trace:
java.lang.AssertionError: expected:<[{indexVersion=1455206967924,generation=2,filelist=[_hak.fdt, _hak.fdx, _hak.fnm, _hak.nvd, _hak.nvm, _hak.si, _hak_Memory_0.ram, _hch.fdt, _hch.fdx, _hch.fnm, _hch.nvd, _hch.nvm, _hch.si, _hch_Memory_0.ram, _hcq.fdt, _hcq.fdx, _hcq.fnm, _hcq.nvd, _hcq.nvm, _hcq.si, _hcq_Memory_0.ram, _hcs.cfe, _hcs.cfs, _hcs.si, _hct.fdt, _hct.fdx, _hct.fnm, _hct.nvd, _hct.nvm, _hct.si, _hct_Memory_0.ram, _hcw.fdt, _hcw.fdx, _hcw.fnm, _hcw.nvd, _hcw.nvm, _hcw.si, _hcw_Memory_0.ram, _hcz.fdt, _hcz.fdx, _hcz.fnm, _hcz.nvd, _hcz.nvm, _hcz.si, _hcz_Memory_0.ram, _hd0.fdt, _hd0.fdx, _hd0.fnm, _hd0.nvd, _hd0.nvm, _hd0.si, _hd0_Memory_0.ram, _hd1.cfe, _hd1.cfs, _hd1.si, _hd2.fdt, _hd2.fdx, _hd2.fnm, _hd2.nvd, _hd2.nvm, _hd2.si, _hd2_Memory_0.ram, _hd3.fdt, _hd3.fdx, _hd3.fnm, _hd3.nvd, _hd3.nvm, _hd3.si, _hd3_Memory_0.ram, _hd5.fdt, _hd5.fdx, _hd5.fnm, _hd5.nvd, _hd5.nvm, _hd5.si, _hd5_Memory_0.ram, _hd7.fdt, _hd7.fdx, _hd7.fnm, _hd7.nvd, _hd7.nvm, _hd7.si, _hd7_Memory_0.ram, _hd8.fdt, _hd8.fdx, _hd8.fnm, _hd8.nvd, _hd8.nvm, _hd8.si, _hd8_Memory_0.ram, _hd9.cfe, _hd9.cfs, _hd9.si, _hdb.fdt, _hdb.fdx, _hdb.fnm, _hdb.nvd, _hdb.nvm, _hdb.si, _hdb_Memory_0.ram, _hdc.fdt, _hdc.fdx, _hdc.fnm, _hdc.nvd, _hdc.nvm, _hdc.si, _hdc_Memory_0.ram, _hdf.fdt, _hdf.fdx, _hdf.fnm, _hdf.nvd, _hdf.nvm, _hdf.si, _hdf_Memory_0.ram, _hdg.fdt, _hdg.fdx, _hdg.fnm, _hdg.nvd, _hdg.nvm, _hdg.si, _hdg_Memory_0.ram, _hdh.fdt, _hdh.fdx, _hdh.fnm, _hdh.nvd, _hdh.nvm, _hdh.si, _hdh_Memory_0.ram, _hdi.fdt, _hdi.fdx, _hdi.fnm, _hdi.nvd, _hdi.nvm, _hdi.si, _hdi_Memory_0.ram, _hdj.fdt, _hdj.fdx, _hdj.fnm, _hdj.nvd, _hdj.nvm, _hdj.si, _hdj_Memory_0.ram, _hek.cfe, _hek.cfs, _hek.si, _hep.fdt, _hep.fdx, _hep.fnm, _hep.nvd, _hep.nvm, _hep.si, _hep_Memory_0.ram, _heq.cfe, _heq.cfs, _heq.si, _her.fdt, _her.fdx, _her.fnm, _her.nvd, _her.nvm, _her.si, _her_Memory_0.ram, _hes.fdt, _hes.fdx, _hes.fnm, _hes.nvd, _hes.nvm, _hes.si, _hes_Memory_0.ram, _het.fdt, _het.fdx, _het.fnm, _het.nvd, _het.nvm, _het.si, _het_Memory_0.ram, _heu.fdt, _heu.fdx, _heu.fnm, _heu.nvd, _heu.nvm, _heu.si, _heu_Memory_0.ram, _hev.fdt, _hev.fdx, _hev.fnm, _hev.nvd, _hev.nvm, _hev.si, _hev_Memory_0.ram, segments_2]}]> but was:<[{indexVersion=1455206967924,generation=2,filelist=[_hak.fdt, _hak.fdx, _hak.fnm, _hak.nvd, _hak.nvm, _hak.si, _hak_Memory_0.ram, _hch.fdt, _hch.fdx, _hch.fnm, _hch.nvd, _hch.nvm, _hch.si, _hch_Memory_0.ram, _hcq.fdt, _hcq.fdx, _hcq.fnm, _hcq.nvd, _hcq.nvm, _hcq.si, _hcq_Memory_0.ram, _hcs.cfe, _hcs.cfs, _hcs.si, _hct.fdt, _hct.fdx, _hct.fnm, _hct.nvd, _hct.nvm, _hct.si, _hct_Memory_0.ram, _hcw.fdt, _hcw.fdx, _hcw.fnm, _hcw.nvd, _hcw.nvm, _hcw.si, _hcw_Memory_0.ram, _hcz.fdt, _hcz.fdx, _hcz.fnm, _hcz.nvd, _hcz.nvm, _hcz.si, _hcz_Memory_0.ram, _hd0.fdt, _hd0.fdx, _hd0.fnm, _hd0.nvd, _hd0.nvm, _hd0.si, _hd0_Memory_0.ram, _hd1.cfe, _hd1.cfs, _hd1.si, _hd2.fdt, _hd2.fdx, _hd2.fnm, _hd2.nvd, _hd2.nvm, _hd2.si, _hd2_Memory_0.ram, _hd3.fdt, _hd3.fdx, _hd3.fnm, _hd3.nvd, _hd3.nvm, _hd3.si, _hd3_Memory_0.ram, _hd5.fdt, _hd5.fdx, _hd5.fnm, _hd5.nvd, _hd5.nvm, _hd5.si, _hd5_Memory_0.ram, _hd7.fdt, _hd7.fdx, _hd7.fnm, _hd7.nvd, _hd7.nvm, _hd7.si, _hd7_Memory_0.ram, _hd8.fdt, _hd8.fdx, _hd8.fnm, _hd8.nvd, _hd8.nvm, _hd8.si, _hd8_Memory_0.ram, _hd9.cfe, _hd9.cfs, _hd9.si, _hdb.fdt, _hdb.fdx, _hdb.fnm, _hdb.nvd, _hdb.nvm, _hdb.si, _hdb_Memory_0.ram, _hdc.fdt, _hdc.fdx, _hdc.fnm, _hdc.nvd, _hdc.nvm, _hdc.si, _hdc_Memory_0.ram, _hdf.fdt, _hdf.fdx, _hdf.fnm, _hdf.nvd, _hdf.nvm, _hdf.si, _hdf_Memory_0.ram, _hdg.fdt, _hdg.fdx, _hdg.fnm, _hdg.nvd, _hdg.nvm, _hdg.si, _hdg_Memory_0.ram, _hdh.fdt, _hdh.fdx, _hdh.fnm, _hdh.nvd, _hdh.nvm, _hdh.si, _hdh_Memory_0.ram, _hdi.fdt, _hdi.fdx, _hdi.fnm, _hdi.nvd, _hdi.nvm, _hdi.si, _hdi_Memory_0.ram, _hdj.fdt, _hdj.fdx, _hdj.fnm, _hdj.nvd, _hdj.nvm, _hdj.si, _hdj_Memory_0.ram, _hek.cfe, _hek.cfs, _hek.si, _hep.fdt, _hep.fdx, _hep.fnm, _hep.nvd, _hep.nvm, _hep.si, _hep_Memory_0.ram, _heq.cfe, _heq.cfs, _heq.si, _her.fdt, _her.fdx, _her.fnm, _her.nvd, _her.nvm, _her.si, _her_Memory_0.ram, _hes.fdt, _hes.fdx, _hes.fnm, _hes.nvd, _hes.nvm, _hes.si, _hes_Memory_0.ram, _het.fdt, _het.fdx, _het.fnm, _het.nvd, _het.nvm, _het.si, _het_Memory_0.ram, _heu.fdt, _heu.fdx, _heu.fnm, _heu.nvd, _heu.nvm, _heu.si, _heu_Memory_0.ram, _hev.fdt, _hev.fdx, _hev.fnm, _hev.nvd, _hev.nvm, _hev.si, _hev_Memory_0.ram, segments_2]}, {indexVersion=1455206967924,generation=3,filelist=[_hdm.fdt, _hdm.fdx, _hdm.fnm, _hdm.nvd, _hdm.nvm, _hdm.si, _hdm_Memory_0.ram, _hek.cfe, _hek.cfs, _hek.si, _heu.fdt, _heu.fdx, _heu.fnm, _heu.nvd, _heu.nvm, _heu.si, _heu_Memory_0.ram, _hev.fdt, _hev.fdx, _hev.fnm, _hev.nvd, _hev.nvm, _hev.si, _hev_Memory_0.ram, _hew.cfe, _hew.cfs, _hew.si, segments_3]}]>
	at __randomizedtesting.SeedInfo.seed([949607EE2A9CF603:B1411CDE5AD4F800]: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:1140)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:497)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 12013 lines...]
   [junit4] Suite: org.apache.solr.handler.TestReplicationHandler
   [junit4]   2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/init-core-data-001
   [junit4]   2> 1936073 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.SolrTestCaseJ4 ###Starting doTestReplicateAfterStartup
   [junit4]   2> 1936074 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/collection1
   [junit4]   2> 1936078 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.e.j.s.Server jetty-9.2.13.v20150730
   [junit4]   2> 1936080 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5d85ccf1{/solr,null,AVAILABLE}
   [junit4]   2> 1936082 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.e.j.s.ServerConnector Started ServerConnector@41e88e3f{HTTP/1.1}{127.0.0.1:48059}
   [junit4]   2> 1936082 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.e.j.s.Server Started @1939025ms
   [junit4]   2> 1936082 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/collection1/data, hostContext=/solr, hostPort=48059}
   [junit4]   2> 1936082 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a
   [junit4]   2> 1936082 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001'
   [junit4]   2> 1936082 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1936082 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
   [junit4]   2> 1936083 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/solr.xml
   [junit4]   2> 1936088 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/.
   [junit4]   2> 1936088 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CoreContainer New CoreContainer 1204871434
   [junit4]   2> 1936088 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001]
   [junit4]   2> 1936088 WARN  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/lib
   [junit4]   2> 1936089 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 1936090 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1936091 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1936091 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1936091 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
   [junit4]   2> 1936091 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 1936092 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/.
   [junit4]   2> 1936096 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data/}
   [junit4]   2> 1936096 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CorePropertiesLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/./collection1
   [junit4]   2> 1936096 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 1936097 INFO  (coreLoadExecutor-8523-thread-1) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/collection1'
   [junit4]   2> 1936097 INFO  (coreLoadExecutor-8523-thread-1) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1936097 INFO  (coreLoadExecutor-8523-thread-1) [    ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
   [junit4]   2> 1936097 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2
   [junit4]   2> 1936097 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 1936112 INFO  (coreLoadExecutor-8523-thread-1) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1936115 INFO  (coreLoadExecutor-8523-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
   [junit4]   2> 1936122 INFO  (coreLoadExecutor-8523-thread-1) [    ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1936124 INFO  (coreLoadExecutor-8523-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1936126 INFO  (coreLoadExecutor-8523-thread-1) [    ] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1936128 INFO  (coreLoadExecutor-8523-thread-1) [    ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/collection1'
   [junit4]   2> 1936128 INFO  (coreLoadExecutor-8523-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/./collection1
   [junit4]   2> 1936128 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1936128 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/./collection1/data/]
   [junit4]   2> 1936128 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
   [junit4]   2> 1936129 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/./collection1/data
   [junit4]   2> 1936129 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/./collection1/data/index/
   [junit4]   2> 1936129 WARN  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/./collection1/data/index' doesn't exist. Creating new index...
   [junit4]   2> 1936130 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/./collection1/data/index
   [junit4]   2> 1936130 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=807663903, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
   [junit4]   2> 1936133 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/index-SimpleFSDirectory-001 lockFactory=org.apache.lucene.store.NativeFSLockFactory@4f2a55f1),segFN=segments_1,generation=1}
   [junit4]   2> 1936133 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1936133 INFO  (OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/./collection1/data/
   [junit4]   2> 1936135 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1936136 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1936137 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1936138 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1936140 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1936141 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy 
   [junit4]   2> 1936141 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,lazy,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/update/csv,/sql,/admin/segments,/admin/system,/replication,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file
   [junit4]   2> 1936141 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1936141 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1936142 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1936142 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@3453c486
   [junit4]   2> 1936143 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/index-SimpleFSDirectory-001 lockFactory=org.apache.lucene.store.NativeFSLockFactory@4f2a55f1),segFN=segments_1,generation=1}
   [junit4]   2> 1936143 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1936143 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3ad56ae7[collection1] main]
   [junit4]   2> 1936143 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/collection1/conf
   [junit4]   2> 1936143 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/collection1/conf}
   [junit4]   2> 1936143 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/collection1/conf
   [junit4]   2> 1936144 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 1936144 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 1936144 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1936144 INFO  (coreLoadExecutor-8523-thread-1) [    x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 1936144 INFO  (searcherExecutor-8524-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3ad56ae7[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1936599 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002/collection1
   [junit4]   2> 1936612 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.e.j.s.Server jetty-9.2.13.v20150730
   [junit4]   2> 1936644 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2bdd0a13{/solr,null,AVAILABLE}
   [junit4]   2> 1936644 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.e.j.s.ServerConnector Started ServerConnector@62f1a515{HTTP/1.1}{127.0.0.1:42535}
   [junit4]   2> 1936644 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.e.j.s.Server Started @1939587ms
   [junit4]   2> 1936644 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002/collection1/data, hostContext=/solr, hostPort=42535}
   [junit4]   2> 1936645 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a
   [junit4]   2> 1936645 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002'
   [junit4]   2> 1936645 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1936645 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
   [junit4]   2> 1936646 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002/solr.xml
   [junit4]   2> 1936652 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002/.
   [junit4]   2> 1936652 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CoreContainer New CoreContainer 79866030
   [junit4]   2> 1936652 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002]
   [junit4]   2> 1936653 WARN  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002/lib
   [junit4]   2> 1936653 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 1936654 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1936655 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1936655 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1936655 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
   [junit4]   2> 1936655 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 1936656 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002/.
   [junit4]   2> 1936657 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data/}
   [junit4]   2> 1936657 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CorePropertiesLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002/./collection1
   [junit4]   2> 1936657 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 1936658 INFO  (coreLoadExecutor-8533-thread-1) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002/collection1'
   [junit4]   2> 1936658 INFO  (coreLoadExecutor-8533-thread-1) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1936658 INFO  (coreLoadExecutor-8533-thread-1) [    ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
   [junit4]   2> 1936665 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2
   [junit4]   2> 1936665 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 1936666 INFO  (coreLoadExecutor-8533-thread-1) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1936670 INFO  (coreLoadExecutor-8533-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
   [junit4]   2> 1936679 INFO  (coreLoadExecutor-8533-thread-1) [    ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1936694 INFO  (coreLoadExecutor-8533-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1936703 INFO  (coreLoadExecutor-8533-thread-1) [    ] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1936705 INFO  (coreLoadExecutor-8533-thread-1) [    ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002/collection1'
   [junit4]   2> 1936705 INFO  (coreLoadExecutor-8533-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002/./collection1
   [junit4]   2> 1936709 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1936710 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002/./collection1/data/]
   [junit4]   2> 1936710 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
   [junit4]   2> 1936710 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002/./collection1/data
   [junit4]   2> 1936710 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002/./collection1/data/index/
   [junit4]   2> 1936710 WARN  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002/./collection1/data/index' doesn't exist. Creating new index...
   [junit4]   2> 1936712 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002/./collection1/data/index
   [junit4]   2> 1936714 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=807663903, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
   [junit4]   2> 1936735 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/index-SimpleFSDirectory-002 lockFactory=org.apache.lucene.store.NativeFSLockFactory@4f2a55f1),segFN=segments_1,generation=1}
   [junit4]   2> 1936735 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1936736 INFO  (OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002/./collection1/data/
   [junit4]   2> 1936737 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1936738 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1936739 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1936740 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1936740 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1936742 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy 
   [junit4]   2> 1936742 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,lazy,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/update/csv,/sql,/admin/segments,/admin/system,/replication,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file
   [junit4]   2> 1936742 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1936743 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1936743 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1936743 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@37cdfc99
   [junit4]   2> 1936744 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/index-SimpleFSDirectory-002 lockFactory=org.apache.lucene.store.NativeFSLockFactory@4f2a55f1),segFN=segments_1,generation=1}
   [junit4]   2> 1936744 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1936744 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1cbd3685[collection1] main]
   [junit4]   2> 1936744 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002/collection1/conf
   [junit4]   2> 1936744 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002/collection1/conf}
   [junit4]   2> 1936744 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002/collection1/conf
   [junit4]   2> 1936745 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 1936765 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
   [junit4]   2> 1936765 INFO  (coreLoadExecutor-8533-thread-1) [    x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 1936765 INFO  (searcherExecutor-8534-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1cbd3685[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1936778 INFO  (qtp757788540-16260) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
   [junit4]   2> 1937169 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.e.j.s.ServerConnector Stopped ServerConnector@62f1a515{HTTP/1.1}{127.0.0.1:0}
   [junit4]   2> 1937169 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=79866030
   [junit4]   2> 1937170 INFO  (coreCloseExecutor-8539-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@7488b0cb
   [junit4]   2> 1937170 INFO  (coreCloseExecutor-8539-thread-1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
   [junit4]   2> 1937170 INFO  (coreCloseExecutor-8539-thread-1) [    x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
   [junit4]   2> 1937171 INFO  (coreCloseExecutor-8539-thread-1) [    x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 1937171 INFO  (coreCloseExecutor-8539-thread-1) [    x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
   [junit4]   2> 1937173 INFO  (coreCloseExecutor-8539-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 1937173 INFO  (coreCloseExecutor-8539-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 1937173 INFO  (coreCloseExecutor-8539-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002/./collection1/data/index [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002/./collection1/data/index;done=false>>]
   [junit4]   2> 1937173 INFO  (coreCloseExecutor-8539-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002/./collection1/data/index
   [junit4]   2> 1937173 INFO  (coreCloseExecutor-8539-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002/./collection1/data [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002/./collection1/data;done=false>>]
   [junit4]   2> 1937173 INFO  (coreCloseExecutor-8539-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-002/./collection1/data
   [junit4]   2> 1937174 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2bdd0a13{/solr,null,UNAVAILABLE}
   [junit4]   2> 1937176 INFO  (qtp757788540-16262) [    x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1937176 INFO  (qtp757788540-16262) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{deleteByQuery=*:*} 0 0
   [junit4]   2> 1937178 INFO  (qtp757788540-16265) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1937179 INFO  (qtp757788540-16265) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/index-SimpleFSDirectory-001 lockFactory=org.apache.lucene.store.NativeFSLockFactory@4f2a55f1),segFN=segments_1,generation=1}
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/index-SimpleFSDirectory-001 lockFactory=org.apache.lucene.store.NativeFSLockFactory@4f2a55f1),segFN=segments_2,generation=2}
   [junit4]   2> 1937181 INFO  (qtp757788540-16265) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 2
   [junit4]   2> 1937182 INFO  (qtp757788540-16265) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@466c11ef[collection1] main]
   [junit4]   2> 1937182 INFO  (qtp757788540-16265) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1937182 INFO  (searcherExecutor-8524-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@466c11ef[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1937182 INFO  (qtp757788540-16265) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 4
   [junit4]   2> 1937189 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.e.j.s.ServerConnector Stopped ServerConnector@41e88e3f{HTTP/1.1}{127.0.0.1:0}
   [junit4]   2> 1937189 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1204871434
   [junit4]   2> 1937191 INFO  (coreCloseExecutor-8540-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@d08f129
   [junit4]   2> 1937191 INFO  (coreCloseExecutor-8540-thread-1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=1,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=1,cumulative_errors=0}
   [junit4]   2> 1937191 INFO  (coreCloseExecutor-8540-thread-1) [    x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
   [junit4]   2> 1937191 INFO  (coreCloseExecutor-8540-thread-1) [    x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 1937191 INFO  (coreCloseExecutor-8540-thread-1) [    x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
   [junit4]   2> 1937193 INFO  (coreCloseExecutor-8540-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 1937193 INFO  (coreCloseExecutor-8540-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 1937193 INFO  (coreCloseExecutor-8540-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/./collection1/data [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/./collection1/data;done=false>>]
   [junit4]   2> 1937193 INFO  (coreCloseExecutor-8540-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/./collection1/data
   [junit4]   2> 1937193 INFO  (coreCloseExecutor-8540-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/./collection1/data/index [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/./collection1/data/index;done=false>>]
   [junit4]   2> 1937194 INFO  (coreCloseExecutor-8540-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/./collection1/data/index
   [junit4]   2> 1937198 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5d85ccf1{/solr,null,UNAVAILABLE}
   [junit4]   2> 1937208 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.e.j.s.Server jetty-9.2.13.v20150730
   [junit4]   2> 1937211 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@75eb6e59{/solr,null,AVAILABLE}
   [junit4]   2> 1937219 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.e.j.s.ServerConnector Started ServerConnector@3415aa85{HTTP/1.1}{127.0.0.1:51211}
   [junit4]   2> 1937219 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.e.j.s.Server Started @1940162ms
   [junit4]   2> 1937219 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/collection1/data, hostContext=/solr, hostPort=51211}
   [junit4]   2> 1937220 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a
   [junit4]   2> 1937220 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001'
   [junit4]   2> 1937220 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1937220 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
   [junit4]   2> 1937220 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/solr.xml
   [junit4]   2> 1937225 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/.
   [junit4]   2> 1937225 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CoreContainer New CoreContainer 1516866015
   [junit4]   2> 1937225 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001]
   [junit4]   2> 1937225 WARN  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/lib
   [junit4]   2> 1937226 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 1937227 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1937227 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1937227 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1937227 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
   [junit4]   2> 1937227 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 1937228 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/.
   [junit4]   2> 1937229 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data/}
   [junit4]   2> 1937229 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CorePropertiesLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/./collection1
   [junit4]   2> 1937229 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 1937230 INFO  (coreLoadExecutor-8546-thread-1) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/collection1'
   [junit4]   2> 1937230 INFO  (coreLoadExecutor-8546-thread-1) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1937230 INFO  (coreLoadExecutor-8546-thread-1) [    ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
   [junit4]   2> 1937230 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2
   [junit4]   2> 1937230 INFO  (TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[949607EE2A9CF603]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 1937236 INFO  (coreLoadExecutor-8546-thread-1) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1937254 INFO  (coreLoadExecutor-8546-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
   [junit4]   2> 1937266 INFO  (coreLoadExecutor-8546-thread-1) [    ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1937268 INFO  (coreLoadExecutor-8546-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1937273 INFO  (coreLoadExecutor-8546-thread-1) [    ] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1937275 INFO  (coreLoadExecutor-8546-thread-1) [    ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/collection1'
   [junit4]   2> 1937275 INFO  (coreLoadExecutor-8546-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/./collection1
   [junit4]   2> 1937275 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1937276 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/./collection1/data/]
   [junit4]   2> 1937276 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
   [junit4]   2> 1937276 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/./collection1/data
   [junit4]   2> 1937276 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/./collection1/data/index/
   [junit4]   2> 1937277 WARN  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/./collection1/data/index' doesn't exist. Creating new index...
   [junit4]   2> 1937277 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/./collection1/data/index
   [junit4]   2> 1937278 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=807663903, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
   [junit4]   2> 1937280 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/index-SimpleFSDirectory-003 lockFactory=org.apache.lucene.store.NativeFSLockFactory@4f2a55f1),segFN=segments_1,generation=1}
   [junit4]   2> 1937280 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1937281 INFO  (OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/./collection1/data/
   [junit4]   2> 1937282 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1937284 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1937285 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1937286 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1937287 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1937288 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy 
   [junit4]   2> 1937289 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,lazy,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/update/csv,/sql,/admin/segments,/admin/system,/replication,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file
   [junit4]   2> 1937289 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1937290 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1937290 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1937290 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@74e401d8
   [junit4]   2> 1937292 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/index-SimpleFSDirectory-003 lockFactory=org.apache.lucene.store.NativeFSLockFactory@4f2a55f1),segFN=segments_1,generation=1}
   [junit4]   2> 1937292 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1937292 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@4c8bea1b[collection1] main]
   [junit4]   2> 1937292 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/collection1/conf
   [junit4]   2> 1937292 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/collection1/conf}
   [junit4]   2> 1937292 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-001/collection1/conf
   [junit4]   2> 1937293 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 1937293 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml
   [junit4]   2> 1937293 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1937293 INFO  (searcherExecutor-8547-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4c8bea1b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1937293 INFO  (coreLoadExecutor-8546-thread-1) [    x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 1937734 INFO  (qtp1430650231-16301) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[0]} 0 0
   [junit4]   2> 1937736 INFO  (qtp1430650231-16302) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[1]} 0 0
   [junit4]   2> 1937738 INFO  (qtp1430650231-16306) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[2]} 0 0
   [junit4]   2> 1937740 INFO  (qtp1430650231-16307) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[3]} 0 0
   [junit4]   2> 1937741 INFO  (qtp1430650231-16305) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[4]} 0 0
   [junit4]   2> 1937744 INFO  (qtp1430650231-16301) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[5]} 0 0
   [junit4]   2> 1937745 INFO  (qtp1430650231-16302) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[6]} 0 0
   [junit4]   2> 1937747 INFO  (qtp1430650231-16306) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[7]} 0 0
   [junit4]   2> 1937749 INFO  (qtp1430650231-16307) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[8]} 0 0
   [junit4]   2> 1937751 INFO  (qtp1430650231-16305) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[9]} 0 0
   [junit4]   2> 1937759 INFO  (qtp1430650231-16301) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[10]} 0 6
   [junit4]   2> 1937761 INFO  (qtp1430650231-16302) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[11]} 0 0
   [junit4]   2> 1937763 INFO  (qtp1430650231-16306) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[12]} 0 0
   [junit4]   2> 1937765 INFO  (qtp1430650231-16307) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[13]} 0 0
   [junit4]   2> 1937766 INFO  (qtp1430650231-16305) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[14]} 0 0
   [junit4]   2> 1937768 INFO  (qtp1430650231-16301) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[15]} 0 0
   [junit4]   2> 1937771 INFO  (qtp1430650231-16302) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[16]} 0 0
   [junit4]   2> 1937772 INFO  (qtp1430650231-16306) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[17]} 0 0
   [junit4]   2> 1937774 INFO  (qtp1430650231-16307) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[18]} 0 0
   [junit4]   2> 1937776 INFO  (qtp1430650231-16305) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[19]} 0 0
   [junit4]   2> 1937778 INFO  (qtp1430650231-16301) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[20]} 0 0
   [junit4]   2> 1937783 INFO  (qtp1430650231-16302) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[21]} 0 2
   [junit4]   2> 1937785 INFO  (qtp1430650231-16306) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[22]} 0 0
   [junit4]   2> 1937786 INFO  (qtp1430650231-16307) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[23]} 0 0
   [junit4]   2> 1937793 INFO  (qtp1430650231-16305) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[24]} 0 0
   [junit4]   2> 1937795 INFO  (qtp1430650231-16301) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[25]} 0 0
   [junit4]   2> 1937797 INFO  (qtp1430650231-16302) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[26]} 0 0
   [junit4]   2> 1937798 INFO  (qtp1430650231-16306) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[27]} 0 0
   [junit4]   2> 1937800 INFO  (qtp1430650231-16307) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[28]} 0 0
   [junit4]   2> 1937801 INFO  (qtp1430650231-16305) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[29]} 0 0
   [junit4]   2> 1937803 INFO  (qtp1430650231-16301) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[30]} 0 0
   [junit4]   2> 1937805 INFO  (qtp1430650231-16302) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[31]} 0 0
   [junit4]   2> 1937813 INFO  (qtp1430650231-16306) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[32]} 0 6
   [junit4]   2> 1937816 INFO  (qtp1430650231-16307) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[33]} 0 0
   [junit4]   2> 1937818 INFO  (qtp1430650231-16305) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[34]} 0 0
   [junit4]   2> 1937819 INFO  (qtp1430650231-16301) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[35]} 0 0
   [junit4]   2> 1937821 INFO  (qtp1430650231-16302) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[36]} 0 0
   [junit4]   2> 1937823 INFO  (qtp1430650231-16306) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[37]} 0 0
   [junit4]   2> 1937825 INFO  (qtp1430650231-16307) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[38]} 0 0
   [junit4]   2> 1937826 INFO  (qtp1430650231-16305) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[39]} 0 0
   [junit4]   2> 1937828 INFO  (qtp1430650231-16301) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[40]} 0 0
   [junit4]   2> 1937830 INFO  (qtp1430650231-16302) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[41]} 0 0
   [junit4]   2> 1937832 INFO  (qtp1430650231-16306) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[42]} 0 0
   [junit4]   2> 1937837 INFO  (qtp1430650231-16307) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[43]} 0 3
   [junit4]   2> 1937841 INFO  (qtp1430650231-16305) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[44]} 0 1
   [junit4]   2> 1937844 INFO  (qtp1430650231-16301) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[45]} 0 0
   [junit4]   2> 1937846 INFO  (qtp1430650231-16302) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[46]} 0 0
   [junit4]   2> 1937848 INFO  (qtp1430650231-16306) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[47]} 0 0
   [junit4]   2> 1937850 INFO  (qtp1430650231-16307) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[48]} 0 0
   [junit4]   2> 1937852 INFO  (qtp1430650231-16305) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[49]} 0 0
   [junit4]   2> 1937854 INFO  (qtp1430650231-16301) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[50]} 0 0
   [junit4]   2> 1937856 INFO  (qtp1430650231-16302) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[51]} 0 0
   [junit4]   2> 1937858 INFO  (qtp1430650231-16306) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[52]} 0 0
   [junit4]   2> 1937860 INFO  (qtp1430650231-16307) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[53]} 0 0
   [junit4]   2> 1937865 INFO  (qtp1430650231-16305) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[54]} 0 3
   [junit4]   2> 1937867 INFO  (qtp1430650231-16301) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[55]} 0 0
   [junit4]   2> 1937869 INFO  (qtp1430650231-16302) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[56]} 0 0
   [junit4]   2> 1937871 INFO  (qtp1430650231-16306) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[57]} 0 0
   [junit4]   2> 1937873 INFO  (qtp1430650231-16307) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[58]} 0 0
   [junit4]   2> 1937875 INFO  (qtp1430650231-16305) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[59]} 0 0
   [junit4]   2> 1937884 INFO  (qtp1430650231-16301) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[60]} 0 0
   [junit4]   2> 1937886 INFO  (qtp1430650231-16302) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[61]} 0 0
   [junit4]   2> 1937887 INFO  (qtp1430650231-16306) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[62]} 0 0
   [junit4]   2> 1937890 INFO  (qtp1430650231-16307) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[63]} 0 0
   [junit4]   2> 1937893 INFO  (qtp1430650231-16305) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[64]} 0 0
   [junit4]   2> 1937899 INFO  (qtp1430650231-16301) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[65]} 0 3
   [junit4]   2> 1937902 INFO  (qtp1430650231-16302) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  weba

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

andler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-027/./collection1/data;done=false>>]
   [junit4]   2> 2709788 INFO  (coreCloseExecutor-9327-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-027/./collection1/data
   [junit4]   2> 2709788 INFO  (coreCloseExecutor-9327-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-027/./collection1/data/index [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-027/./collection1/data/index;done=false>>]
   [junit4]   2> 2709788 INFO  (coreCloseExecutor-9327-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-027/./collection1/data/index
   [junit4]   2> 2709788 INFO  (TEST-TestReplicationHandler.doTestIndexAndConfigReplication-seed#[949607EE2A9CF603]) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@7498ef19{/solr,null,UNAVAILABLE}
   [junit4]   2> 2709792 INFO  (TEST-TestReplicationHandler.doTestIndexAndConfigReplication-seed#[949607EE2A9CF603]) [    ] o.e.j.s.ServerConnector Stopped ServerConnector@7a9d226f{HTTP/1.1}{127.0.0.1:0}
   [junit4]   2> 2709792 INFO  (TEST-TestReplicationHandler.doTestIndexAndConfigReplication-seed#[949607EE2A9CF603]) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=324623704
   [junit4]   2> 2709792 INFO  (coreCloseExecutor-9328-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@9410dfb
   [junit4]   2> 2709793 INFO  (coreCloseExecutor-9328-thread-1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
   [junit4]   2> 2709793 INFO  (coreCloseExecutor-9328-thread-1) [    x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
   [junit4]   2> 2709793 INFO  (coreCloseExecutor-9328-thread-1) [    x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 2709793 INFO  (coreCloseExecutor-9328-thread-1) [    x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
   [junit4]   2> 2709794 INFO  (coreCloseExecutor-9328-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 2709794 INFO  (coreCloseExecutor-9328-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 2709794 INFO  (coreCloseExecutor-9328-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-028/./collection1/data/index [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-028/./collection1/data/index;done=false>>]
   [junit4]   2> 2709794 INFO  (coreCloseExecutor-9328-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-028/./collection1/data/index
   [junit4]   2> 2709795 INFO  (coreCloseExecutor-9328-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-028/./collection1/data [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-028/./collection1/data;done=false>>]
   [junit4]   2> 2709795 INFO  (coreCloseExecutor-9328-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001/solr-instance-028/./collection1/data
   [junit4]   2> 2709795 INFO  (TEST-TestReplicationHandler.doTestIndexAndConfigReplication-seed#[949607EE2A9CF603]) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@a3bfcf9{/solr,null,UNAVAILABLE}
   [junit4]   2> 2709796 INFO  (SUITE-TestReplicationHandler-seed#[949607EE2A9CF603]-worker) [    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_949607EE2A9CF603-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene60): {name=PostingsFormat(name=Memory doPackFST= true), id=PostingsFormat(name=Memory doPackFST= true), newname=PostingsFormat(name=Memory doPackFST= true)}, docValues:{}, sim=ClassicSimilarity, locale=es-GT, timezone=Europe/Sofia
   [junit4]   2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.8.0_66 (64-bit)/cpus=4,threads=1,free=137924784,total=530055168
   [junit4]   2> NOTE: All tests run in this JVM: [CloudMLTQParserTest, TestSchemaResource, TestUtils, LeaderInitiatedRecoveryOnShardRestartTest, TestComplexPhraseQParserPlugin, TestDistribDocBasedVersion, ShowFileRequestHandlerTest, DocValuesMultiTest, TestShardHandlerFactory, SolrCoreCheckLockOnStartupTest, SolrXmlInZkTest, WrapperMergePolicyFactoryTest, TestExceedMaxTermLength, DistributedFacetPivotLargeTest, CustomCollectionTest, TestDefaultSearchFieldResource, TestSort, TestUniqueKeyFieldResource, TestBulkSchemaConcurrent, ClusterStateTest, VMParamsZkACLAndCredentialsProvidersTest, TestSolrQueryParser, DateMathParserTest, TestRecovery, SearchHandlerTest, SuggesterTest, TestAnalyzeInfixSuggestions, TestRawTransformer, TestSha256AuthenticationProvider, TestReload, BadComponentTest, TestPHPSerializedResponseWriter, ConcurrentDeleteAndCreateCollectionTest, FullSolrCloudDistribCmdsTest, TestJmxMonitoredMap, TestPerFieldSimilarity, TestLeaderElectionZkExpiry, TestFieldTypeResource, DocValuesMissingTest, DirectUpdateHandlerTest, BasicDistributedZk2Test, TestSolrJ, CdcrRequestHandlerTest, SpatialHeatmapFacetsTest, SmileWriterTest, TestConfigSetsAPIExclusivity, TestSortByMinMaxFunction, HdfsNNFailoverTest, TestElisionMultitermQuery, TestJmxIntegration, FullHLLTest, BadCopyFieldTest, TestRestoreCore, TestReloadDeadlock, CoreMergeIndexesAdminHandlerTest, TestSolrDeletionPolicy1, TestConfigSetImmutable, TestSolrXml, OverseerTest, SliceStateTest, TestJettySolrRunner, RequestHandlersTest, SampleTest, TestSolrCLIRunExample, DistribCursorPagingTest, SimpleFacetsTest, SparseHLLTest, HdfsDirectoryFactoryTest, DebugComponentTest, SharedFSAutoReplicaFailoverUtilsTest, TestCloudSchemaless, TestSmileRequest, CircularListTest, FieldMutatingUpdateProcessorTest, CollectionStateFormat2Test, TestReversedWildcardFilterFactory, TestSearchPerf, StatsComponentTest, TestCoreDiscovery, QueryParsingTest, DirectSolrConnectionTest, TestCSVResponseWriter, MergeStrategyTest, TestDistribIDF, SuggesterWFSTTest, TestRandomRequestDistribution, TestStressUserVersions, TestInitParams, TestStressReorder, TestCollationField, TestCloudPivotFacet, TestSchemaManager, TestGroupingSearch, CurrencyFieldXmlFileTest, ChaosMonkeySafeLeaderTest, UnloadDistributedZkTest, CollectionsAPIDistributedZkTest, LeaderElectionIntegrationTest, BasicZkTest, RecoveryZkTest, TestReplicationHandler]
   [junit4] Completed [381/579 (1!)] on J2 in 773.77s, 13 tests, 1 failure <<< FAILURES!

[...truncated 645 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:747: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:684: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:59: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build.xml:233: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/common-build.xml:524: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:1457: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:1014: There were test failures: 579 suites (8 ignored), 2327 tests, 1 failure, 34 ignored (18 assumptions) [seed: 949607EE2A9CF603]

Total time: 196 minutes 44 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
No prior successful build to compare, so performing full copy of artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any



Mime
View raw message