Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-trunk/606/

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

Error Message:
expected:<[{indexVersion=1408381432768,generation=2,filelist=[_32.fdt, _32.fdx, 
_32.fnm, _32.nvd, _32.nvm, _32.si, _32_Lucene41_0.doc, _32_Lucene41_0.tim, 
_32_Lucene41_0.tip, _73.fdt, _73.fdx, _73.fnm, _73.nvd, _73.nvm, _73.si, 
_73_Lucene41_0.doc, _73_Lucene41_0.tim, _73_Lucene41_0.tip, _a2.fdt, _a2.fdx, 
_a2.fnm, _a2.nvd, _a2.nvm, _a2.si, _a2_Lucene41_0.doc, _a2_Lucene41_0.tim, 
_a2_Lucene41_0.tip, _d5.fdt, _d5.fdx, _d5.fnm, _d5.nvd, _d5.nvm, _d5.si, 
_d5_Lucene41_0.doc, _d5_Lucene41_0.tim, _d5_Lucene41_0.tip, _dg.cfe, _dg.cfs, 
_dg.si, _dh.cfe, _dh.cfs, _dh.si, _di.cfe, _di.cfs, _di.si, _dj.cfe, _dj.cfs, 
_dj.si, _dk.cfe, _dk.cfs, _dk.si, _dl.cfe, _dl.cfs, _dl.si, _dm.cfe, _dm.cfs, 
_dm.si, _dn.cfe, _dn.cfs, _dn.si, _do.cfe, _do.cfs, _do.si, _dp.cfe, _dp.cfs, 
_dp.si, _dq.cfe, _dq.cfs, _dq.si, segments_2]}]> but 
was:<[{indexVersion=1408381432768,generation=2,filelist=[_32.fdt, _32.fdx, 
_32.fnm, _32.nvd, _32.nvm, _32.si, _32_Lucene41_0.doc, _32_Lucene41_0.tim, 
_32_Lucene41_0.tip, _73.fdt, _73.fdx, _73.fnm, _73.nvd, _73.nvm, _73.si, 
_73_Lucene41_0.doc, _73_Lucene41_0.tim, _73_Lucene41_0.tip, _a2.fdt, _a2.fdx, 
_a2.fnm, _a2.nvd, _a2.nvm, _a2.si, _a2_Lucene41_0.doc, _a2_Lucene41_0.tim, 
_a2_Lucene41_0.tip, _d5.fdt, _d5.fdx, _d5.fnm, _d5.nvd, _d5.nvm, _d5.si, 
_d5_Lucene41_0.doc, _d5_Lucene41_0.tim, _d5_Lucene41_0.tip, _dg.cfe, _dg.cfs, 
_dg.si, _dh.cfe, _dh.cfs, _dh.si, _di.cfe, _di.cfs, _di.si, _dj.cfe, _dj.cfs, 
_dj.si, _dk.cfe, _dk.cfs, _dk.si, _dl.cfe, _dl.cfs, _dl.si, _dm.cfe, _dm.cfs, 
_dm.si, _dn.cfe, _dn.cfs, _dn.si, _do.cfe, _do.cfs, _do.si, _dp.cfe, _dp.cfs, 
_dp.si, _dq.cfe, _dq.cfs, _dq.si, segments_2]}, 
{indexVersion=1408381432768,generation=3,filelist=[_32.fdt, _32.fdx, _32.fnm, 
_32.nvd, _32.nvm, _32.si, _32_Lucene41_0.doc, _32_Lucene41_0.tim, 
_32_Lucene41_0.tip, _73.fdt, _73.fdx, _73.fnm, _73.nvd, _73.nvm, _73.si, 
_73_Lucene41_0.doc, _73_Lucene41_0.tim, _73_Lucene41_0.tip, _a2.fdt, _a2.fdx, 
_a2.fnm, _a2.nvd, _a2.nvm, _a2.si, _a2_Lucene41_0.doc, _a2_Lucene41_0.tim, 
_a2_Lucene41_0.tip, _d5.fdt, _d5.fdx, _d5.fnm, _d5.nvd, _d5.nvm, _d5.si, 
_d5_Lucene41_0.doc, _d5_Lucene41_0.tim, _d5_Lucene41_0.tip, _dq.cfe, _dq.cfs, 
_dq.si, _dr.cfe, _dr.cfs, _dr.si, segments_3]}]>

Stack Trace:
java.lang.AssertionError: 
expected:<[{indexVersion=1408381432768,generation=2,filelist=[_32.fdt, _32.fdx, 
_32.fnm, _32.nvd, _32.nvm, _32.si, _32_Lucene41_0.doc, _32_Lucene41_0.tim, 
_32_Lucene41_0.tip, _73.fdt, _73.fdx, _73.fnm, _73.nvd, _73.nvm, _73.si, 
_73_Lucene41_0.doc, _73_Lucene41_0.tim, _73_Lucene41_0.tip, _a2.fdt, _a2.fdx, 
_a2.fnm, _a2.nvd, _a2.nvm, _a2.si, _a2_Lucene41_0.doc, _a2_Lucene41_0.tim, 
_a2_Lucene41_0.tip, _d5.fdt, _d5.fdx, _d5.fnm, _d5.nvd, _d5.nvm, _d5.si, 
_d5_Lucene41_0.doc, _d5_Lucene41_0.tim, _d5_Lucene41_0.tip, _dg.cfe, _dg.cfs, 
_dg.si, _dh.cfe, _dh.cfs, _dh.si, _di.cfe, _di.cfs, _di.si, _dj.cfe, _dj.cfs, 
_dj.si, _dk.cfe, _dk.cfs, _dk.si, _dl.cfe, _dl.cfs, _dl.si, _dm.cfe, _dm.cfs, 
_dm.si, _dn.cfe, _dn.cfs, _dn.si, _do.cfe, _do.cfs, _do.si, _dp.cfe, _dp.cfs, 
_dp.si, _dq.cfe, _dq.cfs, _dq.si, segments_2]}]> but 
was:<[{indexVersion=1408381432768,generation=2,filelist=[_32.fdt, _32.fdx, 
_32.fnm, _32.nvd, _32.nvm, _32.si, _32_Lucene41_0.doc, _32_Lucene41_0.tim, 
_32_Lucene41_0.tip, _73.fdt, _73.fdx, _73.fnm, _73.nvd, _73.nvm, _73.si, 
_73_Lucene41_0.doc, _73_Lucene41_0.tim, _73_Lucene41_0.tip, _a2.fdt, _a2.fdx, 
_a2.fnm, _a2.nvd, _a2.nvm, _a2.si, _a2_Lucene41_0.doc, _a2_Lucene41_0.tim, 
_a2_Lucene41_0.tip, _d5.fdt, _d5.fdx, _d5.fnm, _d5.nvd, _d5.nvm, _d5.si, 
_d5_Lucene41_0.doc, _d5_Lucene41_0.tim, _d5_Lucene41_0.tip, _dg.cfe, _dg.cfs, 
_dg.si, _dh.cfe, _dh.cfs, _dh.si, _di.cfe, _di.cfs, _di.si, _dj.cfe, _dj.cfs, 
_dj.si, _dk.cfe, _dk.cfs, _dk.si, _dl.cfe, _dl.cfs, _dl.si, _dm.cfe, _dm.cfs, 
_dm.si, _dn.cfe, _dn.cfs, _dn.si, _do.cfe, _do.cfs, _do.si, _dp.cfe, _dp.cfs, 
_dp.si, _dq.cfe, _dq.cfs, _dq.si, segments_2]}, 
{indexVersion=1408381432768,generation=3,filelist=[_32.fdt, _32.fdx, _32.fnm, 
_32.nvd, _32.nvm, _32.si, _32_Lucene41_0.doc, _32_Lucene41_0.tim, 
_32_Lucene41_0.tip, _73.fdt, _73.fdx, _73.fnm, _73.nvd, _73.nvm, _73.si, 
_73_Lucene41_0.doc, _73_Lucene41_0.tim, _73_Lucene41_0.tip, _a2.fdt, _a2.fdx, 
_a2.fnm, _a2.nvd, _a2.nvm, _a2.si, _a2_Lucene41_0.doc, _a2_Lucene41_0.tim, 
_a2_Lucene41_0.tip, _d5.fdt, _d5.fdx, _d5.fnm, _d5.nvd, _d5.nvm, _d5.si, 
_d5_Lucene41_0.doc, _d5_Lucene41_0.tim, _d5_Lucene41_0.tip, _dq.cfe, _dq.cfs, 
_dq.si, _dr.cfe, _dr.cfs, _dr.si, segments_3]}]>
        at 
__randomizedtesting.SeedInfo.seed([AE7D7DF2643D9611:8BAA66C214759812]: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:1190)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:606)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 12360 lines...]
   [junit4] Suite: org.apache.solr.handler.TestReplicationHandler
   [junit4]   2> Creating dataDir: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/init-core-data-001
   [junit4]   2> 3055365 T10601 oas.SolrTestCaseJ4.setUp ###Starting 
doTestDetails
   [junit4]   2> 3055385 T10601 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 3055406 T10601 oejs.AbstractConnector.doStart Started 
[email protected]:18535
   [junit4]   2> 3055407 T10601 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()
   [junit4]   2> 3055408 T10601 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 3055408 T10601 oasc.SolrResourceLoader.locateSolrHome using 
system property solr.solr.home: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001
   [junit4]   2> 3055408 T10601 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/'
   [junit4]   2> 3055466 T10601 oasc.ConfigSolr.fromFile Loading container 
configuration from 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/solr.xml
   [junit4]   2> 3055564 T10601 oasc.CoreContainer.<init> New CoreContainer 
745311751
   [junit4]   2> 3055564 T10601 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/]
   [junit4]   2> 3055567 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting socketTimeout to: 90000
   [junit4]   2> 3055567 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting urlScheme to: 
   [junit4]   2> 3055568 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting connTimeout to: 15000
   [junit4]   2> 3055568 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnectionsPerHost to: 20
   [junit4]   2> 3055568 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting corePoolSize to: 0
   [junit4]   2> 3055569 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting maximumPoolSize to: 2147483647
   [junit4]   2> 3055569 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting maxThreadIdleTime to: 5
   [junit4]   2> 3055570 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting sizeOfQueue to: -1
   [junit4]   2> 3055570 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting fairnessPolicy to: false
   [junit4]   2> 3055571 T10601 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=false
   [junit4]   2> 3055572 T10601 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 3055572 T10601 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 3055573 T10601 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 3055578 T10611 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/'
   [junit4]   2> 3055646 T10611 oasc.SolrConfig.<init> Using Lucene 
MatchVersion: 5.0.0
   [junit4]   2> 3055692 T10611 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 3055693 T10611 oass.IndexSchema.readSchema Reading Solr Schema 
from schema.xml
   [junit4]   2> 3055701 T10611 oass.IndexSchema.readSchema [collection1] 
Schema name=test
   [junit4]   2> 3055722 T10611 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 3055723 T10611 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from instancedir 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/
   [junit4]   2> 3055724 T10611 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 3055724 T10611 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/,
 
dataDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/data/
   [junit4]   2> 3055725 T10611 oasc.SolrCore.<init> JMX monitoring not 
detected for core: collection1
   [junit4]   2> 3055725 T10611 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/data
   [junit4]   2> 3055726 T10611 oasc.SolrCore.getNewIndexDir New index 
directory detected: old=null 
new=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/data/index/
   [junit4]   2> 3055726 T10611 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 3055727 T10611 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/data/index
   [junit4]   2> 3055727 T10611 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=35, maxMergeAtOnceExplicit=41, maxMergedSegmentMB=92.662109375, 
floorSegmentMB=1.890625, forceMergeDeletesPctAllowed=11.828106368149871, 
segmentsPerTier=44.0, maxCFSSegmentSizeMB=1.2841796875, noCFSRatio=1.0
   [junit4]   2> 3055728 T10611 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@612df132 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@322af331),segFN=segments_1,generation=1}
   [junit4]   2> 3055728 T10611 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 3055730 T10611 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 3055730 T10611 oasc.RequestHandlers.initHandlersFromConfig 
created /update: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 3055731 T10611 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 3055731 T10611 oasc.RequestHandlers.initHandlersFromConfig 
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 3055731 T10611 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 3055731 T10611 oasc.RequestHandlers.initHandlersFromConfig 
created standard: solr.StandardRequestHandler
   [junit4]   2> 3055732 T10611 oasc.RequestHandlers.initHandlersFromConfig 
created /replication: solr.ReplicationHandler
   [junit4]   2> 3055732 T10611 oasc.RequestHandlers.initHandlersFromConfig 
created defaults: solr.StandardRequestHandler
   [junit4]   2> 3055732 T10611 oasc.RequestHandlers.initHandlersFromConfig 
adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 3055732 T10611 oasc.RequestHandlers.initHandlersFromConfig 
created lazy: solr.StandardRequestHandler
   [junit4]   2> 3055733 T10611 oasc.RequestHandlers.initHandlersFromConfig 
WARN Multiple requestHandler registered to the same name: /update ignoring: 
org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 3055733 T10611 oasc.RequestHandlers.initHandlersFromConfig 
created /update: solr.UpdateRequestHandler
   [junit4]   2> 3055753 T10611 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 3055756 T10611 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 3055758 T10611 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 3055761 T10611 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 3055763 T10611 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 3055766 T10611 oasu.CommitTracker.<init> Hard AutoCommit: 
disabled
   [junit4]   2> 3055767 T10611 oasu.CommitTracker.<init> Soft AutoCommit: 
disabled
   [junit4]   2> 3055767 T10611 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.AlcoholicMergePolicy: 
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1073635071, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 3055768 T10611 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@612df132 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@322af331),segFN=segments_1,generation=1}
   [junit4]   2> 3055768 T10611 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 3055769 T10611 oass.SolrIndexSearcher.<init> Opening 
Searcher@6396f078[collection1] main
   [junit4]   2> 3055770 T10611 
oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage 
initialized to use dir: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/conf
   [junit4]   2> 3055770 T10611 oasr.RestManager.init Initializing RestManager 
with initArgs: 
{storageDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/conf}
   [junit4]   2> 3055770 T10611 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using 
file:dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/conf
   [junit4]   2> 3055771 T10611 oasr.ManagedResource.reloadFromStorage WARN No 
stored data found for /rest/managed
   [junit4]   2> 3055772 T10611 oasr.ManagedResourceStorage$JsonStorage.store 
Saved JSON object to path _rest_managed.json using 
file:dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/conf
   [junit4]   2> 3055772 T10611 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 3055773 T10611 oash.ReplicationHandler.inform Replication 
enabled for following config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 3055773 T10611 oash.ReplicationHandler.inform Commits will be 
reserved for  10000
   [junit4]   2> 3055773 T10612 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@6396f078[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 3055773 T10611 oasc.CoreContainer.registerCore registering 
core: collection1
   [junit4]   2> 3055774 T10601 oass.SolrDispatchFilter.init 
user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1
   [junit4]   2> 3055775 T10601 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init() done
   [junit4]   2> 3055788 T10601 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 3055793 T10601 oejs.AbstractConnector.doStart Started 
[email protected]:19117
   [junit4]   2> 3055794 T10601 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()
   [junit4]   2> 3055795 T10601 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 3055795 T10601 oasc.SolrResourceLoader.locateSolrHome using 
system property solr.solr.home: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002
   [junit4]   2> 3055796 T10601 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/'
   [junit4]   2> 3055820 T10601 oasc.ConfigSolr.fromFile Loading container 
configuration from 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/solr.xml
   [junit4]   2> 3055878 T10601 oasc.CoreContainer.<init> New CoreContainer 
776816540
   [junit4]   2> 3055879 T10601 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/]
   [junit4]   2> 3055881 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting socketTimeout to: 90000
   [junit4]   2> 3055881 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting urlScheme to: 
   [junit4]   2> 3055882 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting connTimeout to: 15000
   [junit4]   2> 3055882 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnectionsPerHost to: 20
   [junit4]   2> 3055883 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting corePoolSize to: 0
   [junit4]   2> 3055883 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting maximumPoolSize to: 2147483647
   [junit4]   2> 3055884 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting maxThreadIdleTime to: 5
   [junit4]   2> 3055884 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting sizeOfQueue to: -1
   [junit4]   2> 3055885 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting fairnessPolicy to: false
   [junit4]   2> 3055886 T10601 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=false
   [junit4]   2> 3055887 T10601 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 3055887 T10601 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 3055888 T10601 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 3055894 T10623 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/'
   [junit4]   2> 3055944 T10623 oasc.SolrConfig.<init> Using Lucene 
MatchVersion: 5.0.0
   [junit4]   2> 3055997 T10623 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 3055998 T10623 oass.IndexSchema.readSchema Reading Solr Schema 
from schema.xml
   [junit4]   2> 3056004 T10623 oass.IndexSchema.readSchema [collection1] 
Schema name=test
   [junit4]   2> 3056016 T10623 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 3056017 T10623 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from instancedir 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/
   [junit4]   2> 3056017 T10623 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 3056017 T10623 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/,
 
dataDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data/
   [junit4]   2> 3056018 T10623 oasc.SolrCore.<init> JMX monitoring not 
detected for core: collection1
   [junit4]   2> 3056018 T10623 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data
   [junit4]   2> 3056018 T10623 oasc.SolrCore.getNewIndexDir New index 
directory detected: old=null 
new=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data/index/
   [junit4]   2> 3056019 T10623 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 3056021 T10623 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data/index
   [junit4]   2> 3056021 T10623 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=35, maxMergeAtOnceExplicit=41, maxMergedSegmentMB=92.662109375, 
floorSegmentMB=1.890625, forceMergeDeletesPctAllowed=11.828106368149871, 
segmentsPerTier=44.0, maxCFSSegmentSizeMB=1.2841796875, noCFSRatio=1.0
   [junit4]   2> 3056022 T10623 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@157c9c12 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5096ad7a),segFN=segments_1,generation=1}
   [junit4]   2> 3056023 T10623 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 3056024 T10623 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 3056024 T10623 oasc.RequestHandlers.initHandlersFromConfig 
created /update: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 3056024 T10623 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 3056025 T10623 oasc.RequestHandlers.initHandlersFromConfig 
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 3056025 T10623 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 3056025 T10623 oasc.RequestHandlers.initHandlersFromConfig 
created standard: solr.StandardRequestHandler
   [junit4]   2> 3056025 T10623 oasc.RequestHandlers.initHandlersFromConfig 
created defaults: solr.StandardRequestHandler
   [junit4]   2> 3056026 T10623 oasc.RequestHandlers.initHandlersFromConfig 
adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 3056026 T10623 oasc.RequestHandlers.initHandlersFromConfig 
created lazy: solr.StandardRequestHandler
   [junit4]   2> 3056026 T10623 oasc.RequestHandlers.initHandlersFromConfig 
WARN Multiple requestHandler registered to the same name: /update ignoring: 
org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 3056026 T10623 oasc.RequestHandlers.initHandlersFromConfig 
created /update: solr.UpdateRequestHandler
   [junit4]   2> 3056027 T10623 oasc.RequestHandlers.initHandlersFromConfig 
created /replication: solr.ReplicationHandler
   [junit4]   2> 3056029 T10623 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 3056031 T10623 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 3056033 T10623 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 3056035 T10623 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 3056037 T10623 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 3056039 T10623 oasu.CommitTracker.<init> Hard AutoCommit: 
disabled
   [junit4]   2> 3056039 T10623 oasu.CommitTracker.<init> Soft AutoCommit: 
disabled
   [junit4]   2> 3056041 T10623 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.AlcoholicMergePolicy: 
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1073635071, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 3056042 T10623 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@157c9c12 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5096ad7a),segFN=segments_1,generation=1}
   [junit4]   2> 3056042 T10623 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 3056043 T10623 oass.SolrIndexSearcher.<init> Opening 
Searcher@7ac962ec[collection1] main
   [junit4]   2> 3056043 T10623 
oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage 
initialized to use dir: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/conf
   [junit4]   2> 3056043 T10623 oasr.RestManager.init Initializing RestManager 
with initArgs: 
{storageDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/conf}
   [junit4]   2> 3056044 T10623 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using 
file:dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/conf
   [junit4]   2> 3056045 T10623 oasr.ManagedResource.reloadFromStorage WARN No 
stored data found for /rest/managed
   [junit4]   2> 3056045 T10623 oasr.ManagedResourceStorage$JsonStorage.store 
Saved JSON object to path _rest_managed.json using 
file:dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/conf
   [junit4]   2> 3056046 T10623 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 3056052 T10623 oash.SnapPuller.startExecutorService Poll 
Scheduled at an interval of 1000ms
   [junit4]   2> 3056052 T10623 oasc.CoreContainer.registerCore registering 
core: collection1
   [junit4]   2> 3056052 T10624 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@7ac962ec[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 3056053 T10601 oass.SolrDispatchFilter.init 
user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1
   [junit4]   2> 3056053 T10601 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init() done
   [junit4]   2> ASYNC  NEW_CORE C3541 name=collection1 
org.apache.solr.core.SolrCore@7e66d55f
   [junit4]   2> 3056056 T10604 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/select params={wt=javabin&version=2&sort=id+desc&q=*:*} 
hits=0 status=0 QTime=1 
   [junit4]   2> 3056059 T10604 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={command=details&wt=javabin&version=2&_trace=getDetails&qt=/replication} 
status=0 QTime=0 
   [junit4]   2> 3056064 T10605 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={command=details&wt=javabin&version=2&slave=false&qt=/replication} 
status=0 QTime=0 
   [junit4]   2> ASYNC  NEW_CORE C3542 name=collection1 
org.apache.solr.core.SolrCore@42f23344
   [junit4]   2> 3056065 T10616 C3542 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={command=details&wt=javabin&version=2&_trace=getDetails&qt=/replication} 
status=0 QTime=4 
   [junit4]   2> 3056068 T10604 C3541 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0]} 
0 0
   [junit4]   2> 3056071 T10604 C3541 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 3056073 T10604 C3541 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@612df132 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@322af331),segFN=segments_1,generation=1}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@612df132 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@322af331),segFN=segments_2,generation=2}
   [junit4]   2> 3056075 T10604 C3541 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 2
   [junit4]   2> 3056076 T10604 C3541 oass.SolrIndexSearcher.<init> Opening 
Searcher@142fc0a8[collection1] main
   [junit4]   2> 3056076 T10604 C3541 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 3056076 T10612 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@142fc0a8[collection1] 
main{UninvertingDirectoryReader(Uninverting(_0(5.0.0):c1))}
   [junit4]   2> 3056077 T10604 C3541 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update 
params={wt=javabin&version=2&waitSearcher=true&softCommit=false&commit=true} 
{commit=} 0 6
   [junit4]   2> 3056080 T10627 oash.SnapPuller.<init> WARN 'masterUrl' must be 
specified without the /replication suffix
   [junit4]   2> 3056082 T10627 oash.SnapPuller.<init>  No value set for 
'pollInterval'. Timer Task not started.
   [junit4]   2> 3056085 T10605 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={command=indexversion&wt=javabin&version=2&qt=/replication} status=0 
QTime=0 
   [junit4]   2> 3056086 T10627 oash.SnapPuller.fetchLatestIndex Master's 
generation: 2
   [junit4]   2> 3056086 T10627 oash.SnapPuller.fetchLatestIndex Slave's 
generation: 1
   [junit4]   2> 3056086 T10627 oash.SnapPuller.fetchLatestIndex Starting 
replication process
   [junit4]   2> 3056097 T10605 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={command=filelist&wt=javabin&version=2&generation=2&qt=/replication} 
status=0 QTime=8 
   [junit4]   2> 3056098 T10627 oash.SnapPuller.fetchLatestIndex Number of 
files in latest index in master: 4
   [junit4]   2> 3056098 T10627 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data/index.20140818194717851
   [junit4]   2> 3056099 T10627 oasu.DefaultSolrCoreState.closeIndexWriter 
Closing IndexWriter...
   [junit4]   2> 3056099 T10627 oasu.DefaultSolrCoreState.closeIndexWriter 
Waiting until IndexWriter is unused... core=collection1
   [junit4]   2> 3056099 T10627 oasu.DefaultSolrCoreState.closeIndexWriter 
Rollback old IndexWriter... core=collection1
   [junit4]   2> 3056099 T10627 oash.SnapPuller.fetchLatestIndex Starting 
download to MockDirectoryWrapper(RAMDirectory@3962db2c 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@67ddd580) 
fullCopy=false
   [junit4]   2> 3056102 T10605 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={file=segments_2&command=filecontent&wt=filestream&checksum=true&generation=2&qt=/replication}
 status=0 QTime=0 
   [junit4]   2> 3056105 T10605 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={file=_0.cfs&command=filecontent&wt=filestream&checksum=true&generation=2&qt=/replication}
 status=0 QTime=0 
   [junit4]   2> 3056108 T10605 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={file=_0.cfe&command=filecontent&wt=filestream&checksum=true&generation=2&qt=/replication}
 status=0 QTime=0 
   [junit4]   2> 3056111 T10605 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={file=_0.si&command=filecontent&wt=filestream&checksum=true&generation=2&qt=/replication}
 status=0 QTime=0 
   [junit4]   2> 3056112 T10627 oash.SnapPuller.fetchLatestIndex Total time 
taken for download : 0 secs
   [junit4]   2> 3056113 T10627 oasu.DefaultSolrCoreState.openIndexWriter 
Creating new IndexWriter...
   [junit4]   2> 3056114 T10627 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=40, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=74.91796875, 
floorSegmentMB=0.62109375, forceMergeDeletesPctAllowed=10.037093427759533, 
segmentsPerTier=31.0, maxCFSSegmentSizeMB=1.134765625, noCFSRatio=0.0
   [junit4]   2> 3056115 T10627 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@157c9c12 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5096ad7a),segFN=segments_1,generation=1}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@157c9c12 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5096ad7a),segFN=segments_2,generation=2}
   [junit4]   2> 3056117 T10627 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 2
   [junit4]   2> 3056117 T10627 oasu.DefaultSolrCoreState.openIndexWriter New 
IndexWriter is ready to be used.
   [junit4]   2> 3056118 T10627 oass.SolrIndexSearcher.<init> Opening 
Searcher@3f2d1b53[collection1] main
   [junit4]   2> 3056118 T10624 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@3f2d1b53[collection1] 
main{UninvertingDirectoryReader(Uninverting(_0(5.0.0):c1))}
   [junit4]   2> 3056119 T10627 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data/index.20140818194717851
 
[CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data/index.20140818194717851;done=true>>]
   [junit4]   2> 3056119 T10627 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data/index.20140818194717851
   [junit4]   2> 3056119 T10617 C3542 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={command=fetchindex&wait=true&masterUrl=http://127.0.0.1:18535/solr/replication}
 status=0 QTime=40 
   [junit4]   2> 3056126 T10605 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={command=details&wt=javabin&version=2&slave=false&qt=/replication} 
status=0 QTime=0 
   [junit4]   2> 3056128 T10616 C3542 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={command=details&wt=javabin&version=2&_trace=getDetails&qt=/replication} 
status=0 QTime=4 
   [junit4]   2> 3056132 T10604 C3541 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1]} 
0 1
   [junit4]   2> 3056136 T10604 C3541 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 3056140 T10604 C3541 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@612df132 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@322af331),segFN=segments_2,generation=2}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@612df132 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@322af331),segFN=segments_3,generation=3}
   [junit4]   2> 3056141 T10604 C3541 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 3
   [junit4]   2> 3056143 T10604 C3541 oass.SolrIndexSearcher.<init> Opening 
Searcher@57ca5a96[collection1] main
   [junit4]   2> 3056144 T10604 C3541 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 3056144 T10612 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@57ca5a96[collection1] 
main{UninvertingDirectoryReader(Uninverting(_0(5.0.0):c1) 
Uninverting(_1(5.0.0):c1))}
   [junit4]   2> 3056145 T10604 C3541 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update 
params={wt=javabin&version=2&waitSearcher=true&softCommit=false&commit=true} 
{commit=} 0 9
   [junit4]   2> 3056148 T10630 oash.SnapPuller.<init> WARN 'masterUrl' must be 
specified without the /replication suffix
   [junit4]   2> 3056149 T10630 oash.SnapPuller.<init>  No value set for 
'pollInterval'. Timer Task not started.
   [junit4]   2> 3056152 T10605 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={command=indexversion&wt=javabin&version=2&qt=/replication} status=0 
QTime=1 
   [junit4]   2> 3056153 T10630 oash.SnapPuller.fetchLatestIndex Master's 
generation: 3
   [junit4]   2> 3056154 T10630 oash.SnapPuller.fetchLatestIndex Slave's 
generation: 2
   [junit4]   2> 3056154 T10630 oash.SnapPuller.fetchLatestIndex Starting 
replication process
   [junit4]   2> 3056157 T10605 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={command=filelist&wt=javabin&version=2&generation=3&qt=/replication} 
status=0 QTime=1 
   [junit4]   2> 3056159 T10630 oash.SnapPuller.fetchLatestIndex Number of 
files in latest index in master: 7
   [junit4]   2> 3056160 T10630 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data/index.20140818194717912
   [junit4]   2> 3056166 T10630 oasu.DefaultSolrCoreState.closeIndexWriter 
Closing IndexWriter...
   [junit4]   2> 3056167 T10630 oasu.DefaultSolrCoreState.closeIndexWriter 
Waiting until IndexWriter is unused... core=collection1
   [junit4]   2> 3056167 T10630 oasu.DefaultSolrCoreState.closeIndexWriter 
Rollback old IndexWriter... core=collection1
   [junit4]   2> 3056173 T10630 oash.SnapPuller.fetchLatestIndex Starting 
download to MockDirectoryWrapper(RAMDirectory@22f34ef1 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@667dcf2d) 
fullCopy=false
   [junit4]   2> 3056178 T10605 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={file=_1.cfs&command=filecontent&wt=filestream&checksum=true&generation=3&qt=/replication}
 status=0 QTime=1 
   [junit4]   2> 3056185 T10605 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={file=segments_3&command=filecontent&wt=filestream&checksum=true&generation=3&qt=/replication}
 status=0 QTime=1 
   [junit4]   2> 3056188 T10630 oash.SnapPuller.downloadIndexFiles Skipping 
download for _0.cfs because it already exists
   [junit4]   2> 3056191 T10605 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={file=_1.si&command=filecontent&wt=filestream&checksum=true&generation=3&qt=/replication}
 status=0 QTime=0 
   [junit4]   2> 3056195 T10605 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={file=_1.cfe&command=filecontent&wt=filestream&checksum=true&generation=3&qt=/replication}
 status=0 QTime=0 
   [junit4]   2> 3056196 T10630 oash.SnapPuller.downloadIndexFiles Skipping 
download for _0.cfe because it already exists
   [junit4]   2> 3056197 T10630 oash.SnapPuller.downloadIndexFiles Skipping 
download for _0.si because it already exists
   [junit4]   2> 3056197 T10630 oash.SnapPuller.fetchLatestIndex Total time 
taken for download : 0 secs
   [junit4]   2> 3056199 T10630 oasu.DefaultSolrCoreState.openIndexWriter 
Creating new IndexWriter...
   [junit4]   2> 3056199 T10630 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=40, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=74.91796875, 
floorSegmentMB=0.62109375, forceMergeDeletesPctAllowed=10.037093427759533, 
segmentsPerTier=31.0, maxCFSSegmentSizeMB=1.134765625, noCFSRatio=0.0
   [junit4]   2> 3056200 T10630 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@157c9c12 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5096ad7a),segFN=segments_2,generation=2}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@157c9c12 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5096ad7a),segFN=segments_3,generation=3}
   [junit4]   2> 3056200 T10630 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 3
   [junit4]   2> 3056201 T10630 oasu.DefaultSolrCoreState.openIndexWriter New 
IndexWriter is ready to be used.
   [junit4]   2> 3056202 T10630 oass.SolrIndexSearcher.<init> Opening 
Searcher@3d6d2a12[collection1] main
   [junit4]   2> 3056202 T10624 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@3d6d2a12[collection1] 
main{UninvertingDirectoryReader(Uninverting(_0(5.0.0):c1) 
Uninverting(_1(5.0.0):c1))}
   [junit4]   2> 3056202 T10630 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data/index.20140818194717912
 
[CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data/index.20140818194717912;done=true>>]
   [junit4]   2> 3056203 T10630 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data/index.20140818194717912
   [junit4]   2> 3056203 T10617 C3542 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={command=fetchindex&wait=true&masterUrl=http://127.0.0.1:18535/solr/replication}
 status=0 QTime=56 
   [junit4]   2> 3056208 T10605 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={command=details&wt=javabin&version=2&slave=false&qt=/replication} 
status=0 QTime=0 
   [junit4]   2> 3056209 T10616 C3542 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={command=details&wt=javabin&version=2&_trace=getDetails&qt=/replication} 
status=0 QTime=3 
   [junit4]   2> 3056213 T10604 C3541 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2]} 
0 1
   [junit4]   2> 3056216 T10604 C3541 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 3056219 T10604 C3541 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=3
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@612df132 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@322af331),segFN=segments_2,generation=2}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@612df132 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@322af331),segFN=segments_3,generation=3}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@612df132 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@322af331),segFN=segments_4,generation=4}
   [junit4]   2> 3056219 T10604 C3541 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 4
   [junit4]   2> 3056220 T10604 C3541 oass.SolrIndexSearcher.<init> Opening 
Searcher@138c9f85[collection1] main
   [junit4]   2> 3056221 T10604 C3541 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 3056221 T10612 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@138c9f85[collection1] 
main{UninvertingDirectoryReader(Uninverting(_0(5.0.0):c1) 
Uninverting(_1(5.0.0):c1) Uninverting(_2(5.0.0):c1))}
   [junit4]   2> 3056222 T10604 C3541 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update 
params={wt=javabin&version=2&waitSearcher=true&softCommit=false&commit=true} 
{commit=} 0 6
   [junit4]   2> 3056224 T10632 oash.SnapPuller.<init> WARN 'masterUrl' must be 
specified without the /replication suffix
   [junit4]   2> 3056224 T10632 oash.SnapPuller.<init>  No value set for 
'pollInterval'. Timer Task not started.
   [junit4]   2> 3056227 T10605 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={command=indexversion&wt=javabin&version=2&qt=/replication} status=0 
QTime=0 
   [junit4]   2> 3056228 T10632 oash.SnapPuller.fetchLatestIndex Master's 
generation: 4
   [junit4]   2> 3056228 T10632 oash.SnapPuller.fetchLatestIndex Slave's 
generation: 3
   [junit4]   2> 3056228 T10632 oash.SnapPuller.fetchLatestIndex Starting 
replication process
   [junit4]   2> 3056231 T10605 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={command=filelist&wt=javabin&version=2&generation=4&qt=/replication} 
status=0 QTime=0 
   [junit4]   2> 3056232 T10632 oash.SnapPuller.fetchLatestIndex Number of 
files in latest index in master: 10
   [junit4]   2> 3056233 T10632 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data/index.20140818194717986
   [junit4]   2> 3056234 T10632 oasu.DefaultSolrCoreState.closeIndexWriter 
Closing IndexWriter...
   [junit4]   2> 3056234 T10632 oasu.DefaultSolrCoreState.closeIndexWriter 
Waiting until IndexWriter is unused... core=collection1
   [junit4]   2> 3056234 T10632 oasu.DefaultSolrCoreState.closeIndexWriter 
Rollback old IndexWriter... core=collection1
   [junit4]   2> 3056237 T10632 oash.SnapPuller.fetchLatestIndex Starting 
download to MockDirectoryWrapper(RAMDirectory@43918d3 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@29ae41d7) 
fullCopy=false
   [junit4]   2> 3056237 T10632 oash.SnapPuller.downloadIndexFiles Skipping 
download for _1.cfs because it already exists
   [junit4]   2> 3056240 T10605 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={file=_2.cfe&command=filecontent&wt=filestream&checksum=true&generation=4&qt=/replication}
 status=0 QTime=0 
   [junit4]   2> 3056242 T10632 oash.SnapPuller.downloadIndexFiles Skipping 
download for _0.cfs because it already exists
   [junit4]   2> 3056245 T10605 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={file=_2.si&command=filecontent&wt=filestream&checksum=true&generation=4&qt=/replication}
 status=0 QTime=0 
   [junit4]   2> 3056246 T10632 oash.SnapPuller.downloadIndexFiles Skipping 
download for _1.si because it already exists
   [junit4]   2> 3056249 T10605 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={file=_2.cfs&command=filecontent&wt=filestream&checksum=true&generation=4&qt=/replication}
 status=0 QTime=0 
   [junit4]   2> 3056250 T10632 oash.SnapPuller.downloadIndexFiles Skipping 
download for _1.cfe because it already exists
   [junit4]   2> 3056250 T10632 oash.SnapPuller.downloadIndexFiles Skipping 
download for _0.cfe because it already exists
   [junit4]   2> 3056253 T10605 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={file=segments_4&command=filecontent&wt=filestream&checksum=true&generation=4&qt=/replication}
 status=0 QTime=0 
   [junit4]   2> 3056254 T10632 oash.SnapPuller.downloadIndexFiles Skipping 
download for _0.si because it already exists
   [junit4]   2> 3056255 T10632 oash.SnapPuller.fetchLatestIndex Total time 
taken for download : 0 secs
   [junit4]   2> 3056257 T10632 oasu.DefaultSolrCoreState.openIndexWriter 
Creating new IndexWriter...
   [junit4]   2> 3056257 T10632 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=40, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=74.91796875, 
floorSegmentMB=0.62109375, forceMergeDeletesPctAllowed=10.037093427759533, 
segmentsPerTier=31.0, maxCFSSegmentSizeMB=1.134765625, noCFSRatio=0.0
   [junit4]   2> 3056259 T10632 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@157c9c12 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5096ad7a),segFN=segments_3,generation=3}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@157c9c12 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5096ad7a),segFN=segments_4,generation=4}
   [junit4]   2> 3056259 T10632 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 4
   [junit4]   2> 3056259 T10632 oasu.DefaultSolrCoreState.openIndexWriter New 
IndexWriter is ready to be used.
   [junit4]   2> 3056261 T10632 oass.SolrIndexSearcher.<init> Opening 
Searcher@2e33033e[collection1] main
   [junit4]   2> 3056261 T10624 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@2e33033e[collection1] 
main{UninvertingDirectoryReader(Uninverting(_0(5.0.0):c1) 
Uninverting(_1(5.0.0):c1) Uninverting(_2(5.0.0):c1))}
   [junit4]   2> 3056262 T10632 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data/index.20140818194717986
 
[CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data/index.20140818194717986;done=true>>]
   [junit4]   2> 3056262 T10632 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data/index.20140818194717986
   [junit4]   2> 3056262 T10617 C3542 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={command=fetchindex&wait=true&masterUrl=http://127.0.0.1:18535/solr/replication}
 status=0 QTime=39 
   [junit4]   2> 3056282 T10601 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 3056289 T10601 oejs.AbstractConnector.doStart Started 
[email protected]:19363
   [junit4]   2> 3056290 T10601 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()
   [junit4]   2> 3056291 T10601 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 3056291 T10601 oasc.SolrResourceLoader.locateSolrHome using 
system property solr.solr.home: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-003
   [junit4]   2> 3056291 T10601 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-003/'
   [junit4]   2> 3056348 T10601 oasc.ConfigSolr.fromFile Loading container 
configuration from 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-003/solr.xml
   [junit4]   2> 3056447 T10601 oasc.CoreContainer.<init> New CoreContainer 
108448647
   [junit4]   2> 3056447 T10601 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-003/]
   [junit4]   2> 3056449 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting socketTimeout to: 90000
   [junit4]   2> 3056449 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting urlScheme to: 
   [junit4]   2> 3056449 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting connTimeout to: 15000
   [junit4]   2> 3056450 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnectionsPerHost to: 20
   [junit4]   2> 3056450 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting corePoolSize to: 0
   [junit4]   2> 3056451 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting maximumPoolSize to: 2147483647
   [junit4]   2> 3056451 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting maxThreadIdleTime to: 5
   [junit4]   2> 3056451 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting sizeOfQueue to: -1
   [junit4]   2> 3056452 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting fairnessPolicy to: false
   [junit4]   2> 3056453 T10601 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=false
   [junit4]   2> 3056453 T10601 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 3056454 T10601 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 3056454 T10601 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 3056459 T10643 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-003/collection1/'
   [junit4]   2> 3056525 T10643 oasc.SolrConfig.<init> Using Lucene 
MatchVersion: 5.0.0
   [junit4]   2> 3056570 T10643 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 3056572 T10643 oass.IndexSchema.readSchema Reading Solr Schema 
from schema.xml
   [junit4]   2> 3056580 T10643 oass.IndexSchema.readSchema [collection1] 
Schema name=test
   [junit4]   2> 3056600 T10643 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 3056601 T10643 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from instancedir 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-003/collection1/
   [junit4]   2> 3056601 T10643 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 3056601 T10643 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-003/collection1/,
 
dataDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-003/collection1/data/
   [junit4]   2> 3056602 T10643 oasc.SolrCore.<init> JMX monitoring not 
detected for core: collection1
   [junit4]   2> 3056603 T10643 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-003/collection1/data
   [junit4]   2> 3056603 T10643 oasc.SolrCore.getNewIndexDir New index 
directory detected: old=null 
new=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-003/collection1/data/index/
   [junit4]   2> 3056603 T10643 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-003/collection1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 3056604 T10643 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-003/collection1/data/index
   [junit4]   2> 3056604 T10643 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=35, maxMergeAtOnceExplicit=41, maxMergedSegmentMB=92.662109375, 
floorSegmentMB=1.890625, forceMergeDeletesPctAllowed=11.828106368149871, 
segmentsPerTier=44.0, maxCFSSegmentSizeMB=1.2841796875, noCFSRatio=1.0
   [junit4]   2> 3056605 T10643 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@6396f328 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@732b1b91),segFN=segments_1,generation=1}
   [junit4]   2> 3056605 T10643 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 3056607 T10643 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 3056607 T10643 oasc.RequestHandlers.initHandlersFromConfig 
created /update: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 3056608 T10643 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 3056608 T10643 oasc.RequestHandlers.initHandlersFromConfig 
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 3056608 T10643 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 3056609 T10643 oasc.RequestHandlers.initHandlersFromConfig 
created standard: solr.StandardRequestHandler
   [junit4]   2> 3056609 T10643 oasc.RequestHandlers.initHandlersFromConfig 
created defaults: solr.StandardRequestHandler
   [junit4]   2> 3056609 T10643 oasc.RequestHandlers.initHandlersFromConfig 
adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 3056610 T10643 oasc.RequestHandlers.initHandlersFromConfig 
created lazy: solr.StandardRequestHandler
   [junit4]   2> 3056610 T10643 oasc.RequestHandlers.initHandlersFromConfig 
WARN Multiple requestHandler registered to the same name: /update ignoring: 
org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 3056610 T10643 oasc.RequestHandlers.initHandlersFromConfig 
created /update: solr.UpdateRequestHandler
   [junit4]   2> 3056610 T10643 oasc.RequestHandlers.initHandlersFromConfig 
created /replication: solr.ReplicationHandler
   [junit4]   2> 3056636 T10643 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 3056638 T10643 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 3056640 T10643 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 3056642 T10643 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 3056644 T10643 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 3056646 T10643 oasu.CommitTracker.<init> Hard AutoCommit: 
disabled
   [junit4]   2> 3056646 T10643 oasu.CommitTracker.<init> Soft AutoCommit: 
disabled
   [junit4]   2> 3056647 T10643 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.AlcoholicMergePolicy: 
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1073635071, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 3056648 T10643 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@6396f328 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@732b1b91),segFN=segments_1,generation=1}
   [junit4]   2> 3056648 T10643 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 3056649 T10643 oass.SolrIndexSearcher.<init> Opening 
Searcher@180f2dd4[collection1] main
   [junit4]   2> 3056649 T10643 
oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage 
initialized to use dir: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-003/collection1/conf
   [junit4]   2> 3056650 T10643 oasr.RestManager.init Initializing RestManager 
with initArgs: 
{storageDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-003/collection1/conf}
   [junit4]   2> 3056650 T10643 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using 
file:dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-003/collection1/conf
   [junit4]   2> 3056651 T10643 oasr.ManagedResource.reloadFromStorage WARN No 
stored data found for /rest/managed
   [junit4]   2> 3056652 T10643 oasr.ManagedResourceStorage$JsonStorage.store 
Saved JSON object to path _rest_managed.json using 
file:dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-003/collection1/conf
   [junit4]   2> 3056652 T10643 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 3056652 T10643 oash.SnapPuller.<init> WARN 'masterUrl' must be 
specified without the /replication suffix
   [junit4]   2> 3056653 T10643 oash.SnapPuller.<init>  No value set for 
'pollInterval'. Timer Task not started.
   [junit4]   2> 3056653 T10643 oash.ReplicationHandler.inform Replication 
enabled for following config files: schema.xml
   [junit4]   2> 3056653 T10643 oash.ReplicationHandler.inform Commits will be 
reserved for  10000
   [junit4]   2> 3056654 T10643 oasc.CoreContainer.registerCore registering 
core: collection1
   [junit4]   2> 3056654 T10644 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@180f2dd4[collection1] 
main{UninvertingDirectoryReader()}
   [junit4]   2> 3056654 T10601 oass.SolrDispatchFilter.init 
user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1
   [junit4]   2> 3056655 T10601 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init() done
   [junit4]   2> 3056663 T10606 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={command=details&wt=javabin&version=2&slave=false&qt=/replication} 
status=0 QTime=1 
   [junit4]   2> ASYNC  NEW_CORE C3543 name=collection1 
org.apache.solr.core.SolrCore@72f71510
   [junit4]   2> 3056664 T10636 C3543 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={command=details&wt=javabin&version=2&_trace=getDetails&qt=/replication} 
status=0 QTime=6 
   [junit4]   2> 3056665 T10601 oasc.CoreContainer.shutdown Shutting down 
CoreContainer instance=108448647
   [junit4]   2> 3056671 T10601 oasc.SolrCore.close [collection1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@72f71510
   [junit4]   2> 3056671 T10601 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=0,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
   [junit4]   2> 3056672 T10601 oasu.SolrCoreState.decrefSolrCoreState Closing 
SolrCoreState
   [junit4]   2> 3056672 T10601 oasu.DefaultSolrCoreState.closeIndexWriter 
SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 3056673 T10601 oasu.DefaultSolrCoreState.closeIndexWriter 
closing IndexWriter with IndexWriterCloser
   [junit4]   2> 3056673 T10601 oasc.SolrCore.closeSearcher [collection1] 
Closing main searcher on request.
   [junit4]   2> 3056674 T10601 oasc.CachingDirectoryFactory.close Closing 
MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 3056674 T10601 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-003/collection1/data/index
 
[CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-003/collection1/data/index;done=false>>]
   [junit4]   2> 3056675 T10601 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-003/collection1/data/index
   [junit4]   2> 3056676 T10601 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-003/collection1/data
 
[CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-003/collection1/data;done=false>>]
   [junit4]   2> 3056676 T10601 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-003/collection1/data
   [junit4]   2> 3056677 T10601 oejsh.ContextHandler.doStop stopped 
o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 3057257 T10605 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={command=indexversion&wt=javabin&version=2&qt=/replication} status=0 
QTime=1 
   [junit4]   2> 3057258 T10625 oash.SnapPuller.fetchLatestIndex Slave in sync 
with master.
   [junit4]   2> 3058250 T10605 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={command=indexversion&wt=javabin&version=2&qt=/replication} status=0 
QTime=0 
   [junit4]   2> 3058251 T10625 oash.SnapPuller.fetchLatestIndex Slave in sync 
with master.
   [junit4]   2> 3059252 T10605 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={command=indexversion&wt=javabin&version=2&qt=/replication} status=0 
QTime=0 
   [junit4]   2> 3059253 T10625 oash.SnapPuller.fetchLatestIndex Slave in sync 
with master.
   [junit4]   2> 3060250 T10605 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={command=indexversion&wt=javabin&version=2&qt=/replication} status=0 
QTime=0 
   [junit4]   2> 3060251 T10625 oash.SnapPuller.fetchLatestIndex Slave in sync 
with master.
   [junit4]   2> 3061250 T10605 C3541 oasc.SolrCore.execute [collection1] 
webapp=/solr path=/replication 
params={command=indexversion&wt=javabin&version=2&qt=/replication} status=0 
QTime=0 
   [junit4]   2> 3061251 T10625 oash.SnapPuller.fetchLatestIndex Slave in sync 
with master.
   [junit4]   2> 3061676 T10601 oas.SolrTestCaseJ4.tearDown ###Ending 
doTestDetails
   [junit4]   2> 3061677 T10601 oasc.CoreContainer.shutdown Shutting down 
CoreContainer instance=745311751
   [junit4]   2> 3061684 T10601 oasc.SolrCore.close [collection1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@7e66d55f
   [junit4]   2> 3061685 T10601 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=3,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=3,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
   [junit4]   2> 3061690 T10601 oasu.SolrCoreState.decrefSolrCoreState Closing 
SolrCoreState
   [junit4]   2> 3061691 T10601 oasu.DefaultSolrCoreState.closeIndexWriter 
SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 3061691 T10601 oasu.DefaultSolrCoreState.closeIndexWriter 
closing IndexWriter with IndexWriterCloser
   [junit4]   2> 3061695 T10601 oasc.SolrCore.closeSearcher [collection1] 
Closing main searcher on request.
   [junit4]   2> 3061695 T10601 oasc.CachingDirectoryFactory.close Closing 
MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 3061696 T10601 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/data
 
[CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/data;done=false>>]
   [junit4]   2> 3061696 T10601 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/data
   [junit4]   2> 3061697 T10601 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/data/index
 
[CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/data/index;done=false>>]
   [junit4]   2> 3061697 T10601 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/data/index
   [junit4]   2> 3061698 T10601 oejsh.ContextHandler.doStop stopped 
o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 3066684 T10601 oasc.CoreContainer.shutdown Shutting down 
CoreContainer instance=776816540
   [junit4]   2> 3066687 T10601 oasc.SolrCore.close [collection1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@42f23344
   [junit4]   2> 3077251 T10625 oash.SnapPuller.fetchLatestIndex ERROR Master 
at: http://127.0.0.1:18535/solr is not available. Index fetch failed. 
Exception: IOException occured when talking to server at: 
http://127.0.0.1:18535/solr
   [junit4]   2> 3077255 T10601 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=0,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
   [junit4]   2> 3077256 T10601 oasu.SolrCoreState.decrefSolrCoreState Closing 
SolrCoreState
   [junit4]   2> 3077257 T10601 oasu.DefaultSolrCoreState.closeIndexWriter 
SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 3077257 T10601 oasu.DefaultSolrCoreState.closeIndexWriter 
closing IndexWriter with IndexWriterCloser
   [junit4]   2> 3077260 T10601 oasc.SolrCore.closeSearcher [collection1] 
Closing main searcher on request.
   [junit4]   2> 3077261 T10601 oasc.CachingDirectoryFactory.close Closing 
MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 3077262 T10601 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data
 
[CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data;done=false>>]
   [junit4]   2> 3077262 T10601 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data
   [junit4]   2> 3077263 T10601 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data/index
 
[CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data/index;done=false>>]
   [junit4]   2> 3077263 T10601 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data/index
   [junit4]   2> 3077266 T10601 oejsh.ContextHandler.doStop stopped 
o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 3081714 T10601 oas.SolrTestCaseJ4.setUp ###Starting 
doTestReplicateAfterStartupWithNoActivity
   [junit4]   2> 3081735 T10601 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 3081742 T10601 oejs.AbstractConnector.doStart Started 
[email protected]:53666
   [junit4]   2> 3081743 T10601 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()
   [junit4]   2> 3081744 T10601 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 3081744 T10601 oasc.SolrResourceLoader.locateSolrHome using 
system property solr.solr.home: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001
   [junit4]   2> 3081745 T10601 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/'
   [junit4]   2> 3081805 T10601 oasc.ConfigSolr.fromFile Loading container 
configuration from 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/solr.xml
   [junit4]   2> 3081922 T10601 oasc.CoreContainer.<init> New CoreContainer 
1072481
   [junit4]   2> 3081922 T10601 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/]
   [junit4]   2> 3081924 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting socketTimeout to: 90000
   [junit4]   2> 3081925 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting urlScheme to: 
   [junit4]   2> 3081925 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting connTimeout to: 15000
   [junit4]   2> 3081925 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnectionsPerHost to: 20
   [junit4]   2> 3081926 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting corePoolSize to: 0
   [junit4]   2> 3081926 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting maximumPoolSize to: 2147483647
   [junit4]   2> 3081927 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting maxThreadIdleTime to: 5
   [junit4]   2> 3081927 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting sizeOfQueue to: -1
   [junit4]   2> 3081927 T10601 oashc.HttpShardHandlerFactory.getParameter 
Setting fairnessPolicy to: false
   [junit4]   2> 3081928 T10601 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=false
   [junit4]   2> 3081929 T10601 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 3081929 T10601 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 3081930 T10601 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 3081936 T10655 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/'
   [junit4]   2> 3081998 T10655 oasc.SolrConfig.<init> Using Lucene 
MatchVersion: 5.0.0
   [junit4]   2> 3082050 T10655 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 3082051 T10655 oass.IndexSchema.readSchema Reading Solr Schema 
from schema.xml
   [junit4]   2> 3082059 T10655 oass.IndexSchema.readSchema [collection1] 
Schema name=test
   [junit4]   2> 3082079 T10655 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 3082081 T10655 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from instancedir 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/
   [junit4]   2> 3082082 T10655 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 3082083 T10655 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/,
 
dataDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/data/
   [junit4]   2> 3082084 T10655 oasc.SolrCore.<init> JMX monitoring not 
detected for core: collection1
   [junit4]   2> 3082086 T10655 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/data
   [junit4]   2> 3082087 T10655 oasc.SolrCore.getNewIndexDir New index 
directory detected: old=null 
new=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/data/index/
   [junit4]   2> 3082087 T10655 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 3082088 T10655 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/data/index
   [junit4]   2> 3082088 T10655 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=35, maxMergeAtOnceExplicit=41, maxMergedSegmentMB=92.662109375, 
floorSegmentMB=1.890625, forceMergeDeletesPctAllowed=11.828106368149871, 
segmentsPerTier=44.0, maxCFSSegmentSizeMB=1.2841796875, noCFSRatio=1.0
   [junit4]   2> 3082089 T10655 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@6febcdd0 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@416aa9ef),segFN=segments_1,generation=1}
   [junit4]   2> 3082089 T10655 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 3082091 T10655 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 3082091 T10655 oasc.RequestHandlers.initHandlersFromConfig 
created /update: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 3082091 T10655 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 3082092 T10655 oasc.RequestHandlers.initHandlersFromConfig 
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 3082092 T10655 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 3082092 T10655 oasc.RequestHandlers.initHandlersFromConfig 
created standard: solr.StandardRequestHandler
   [junit4]   2> 3082093 T10655 oasc.RequestHandlers.initHandlersFromConfig 
created /replication: solr.ReplicationHandler
   [junit4]   2> 3082093 T10655 oasc.RequestHandlers.initHandlersFromConfig 
created defaults: solr.StandardRequestHandler
   [junit4]   2> 3082093 T10655 oasc.RequestHandlers.initHandlersFromConfig 
adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 3082093 T10655 oasc.RequestHandlers.initHandlersFromConfig 
created lazy: solr.StandardRequestHandler
   [junit4]   2> 3082093 T10655 oasc.RequestHandlers.initHandlersFromConfig 
WARN Multiple requestHandler registered to the same name: /update ignoring: 
org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 3082094 T10655 oasc.RequestHandlers.initHandlersFromConfig 
created /update: solr.UpdateRequestHandler
   [junit4]   2> 3082115 T10655 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 3082118 T10655 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 3082121 T10655 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 3082123 T10655 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 3082126 T10655 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 3082128 T10655 oasu.C

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

er
   [junit4]   2> 4081089 T10601 oasu.DefaultSolrCoreState.closeIndexWriter 
closing IndexWriter with IndexWriterCloser
   [junit4]   2> 4081092 T10601 oasc.SolrCore.closeSearcher [collection1] 
Closing main searcher on request.
   [junit4]   2> 4081092 T10601 oasc.CachingDirectoryFactory.close Closing 
MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 4081093 T10601 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/data/index.20140818200422705
 
[CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/data/index.20140818200422705;done=false>>]
   [junit4]   2> 4081093 T10601 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/data/index.20140818200422705
   [junit4]   2> 4081094 T10601 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/data
 
[CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/data;done=false>>]
   [junit4]   2> 4081094 T10601 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-001/collection1/data
   [junit4]   2> 4081095 T10601 oejsh.ContextHandler.doStop stopped 
o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 4086085 T10601 oasc.CoreContainer.shutdown Shutting down 
CoreContainer instance=481556136
   [junit4]   2> 4086087 T10601 oasc.SolrCore.close [collection1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@183f6706
   [junit4]   2> 4086088 T10601 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=2,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=3,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
   [junit4]   2> 4086094 T10601 oasu.SolrCoreState.decrefSolrCoreState Closing 
SolrCoreState
   [junit4]   2> 4086094 T10601 oasu.DefaultSolrCoreState.closeIndexWriter 
SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 4086094 T10601 oasu.DefaultSolrCoreState.closeIndexWriter 
closing IndexWriter with IndexWriterCloser
   [junit4]   2> 4086095 T10601 oasc.SolrCore.closeSearcher [collection1] 
Closing main searcher on request.
   [junit4]   2> 4086096 T10601 oasc.CachingDirectoryFactory.close Closing 
MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 4086096 T10601 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data/index.20140818200422449
 
[CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data/index.20140818200422449;done=false>>]
   [junit4]   2> 4086096 T10601 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data/index.20140818200422449
   [junit4]   2> 4086096 T10601 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data
 
[CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data;done=false>>]
   [junit4]   2> 4086097 T10601 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001/solr-instance-002/collection1/data
   [junit4]   2> 4086097 T10601 oejsh.ContextHandler.doStop stopped 
o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 4091111 T10601 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./temp/solr.handler.TestReplicationHandler-AE7D7DF2643D9611-001
   [junit4]   2> NOTE: test params are: codec=Lucene45, 
sim=RandomSimilarityProvider(queryNorm=false,coord=crazy): {}, locale=en_GB, 
timezone=Asia/Aden
   [junit4]   2> NOTE: FreeBSD 9.1-RELEASE-p3 amd64/Oracle Corporation 1.7.0_60 
(64-bit)/cpus=16,threads=1,free=219862904,total=474480640
   [junit4]   2> NOTE: All tests run in this JVM: [ResourceLoaderTest, 
CoreContainerCoreInitFailuresTest, CopyFieldTest, SolrXmlInZkTest, 
RemoteQueryErrorTest, CursorPagingTest, DirectUpdateHandlerOptimizeTest, 
TestFieldSortValues, TestMultiCoreConfBootstrap, BasicZkTest, 
TestExceedMaxTermLength, TestXIncludeConfig, TestDistributedGrouping, 
TestAddFieldRealTimeGet, BasicDistributedZk2Test, TestCSVLoader, 
CustomCollectionTest, CoreMergeIndexesAdminHandlerTest, SearchHandlerTest, 
SynonymTokenizerTest, PrimUtilsTest, DocValuesTest, SliceStateTest, 
TestSolrXml, TestMergePolicyConfig, DistanceFunctionTest, 
UniqFieldsUpdateProcessorFactoryTest, NumericFieldsTest, 
FullSolrCloudDistribCmdsTest, TestIntervalFaceting, TestCollationField, 
TestZkChroot, AddSchemaFieldsUpdateProcessorFactoryTest, MultiThreadedOCPTest, 
TestLeaderElectionZkExpiry, TestBadConfig, TestManagedResource, 
DistributedFacetPivotLongTailTest, TestDocBasedVersionConstraints, 
SortByFunctionTest, TestCSVResponseWriter, TestJoin, RAMDirectoryFactoryTest, 
TestRecoveryHdfs, TestMissingGroups, TestQueryUtils, TestStandardQParsers, 
TestBM25SimilarityFactory, DateMathParserTest, AnalysisAfterCoreReloadTest, 
TestPerFieldSimilarity, TestLFUCache, CollectionsAPIDistributedZkTest, 
LeaderElectionIntegrationTest, HdfsBasicDistributedZk2Test, SampleTest, 
HdfsSyncSliceTest, TestBinaryField, DistributedQueryComponentCustomSortTest, 
SpatialFilterTest, FieldAnalysisRequestHandlerTest, TestPhraseSuggestions, 
TestRecovery, TermVectorComponentTest, TestFieldResource, 
TestSolrQueryParserResource, SimplePostToolTest, CircularListTest, 
TestUniqueKeyFieldResource, TestImplicitCoreProperties, RequestHandlersTest, 
LegacyHTMLStripCharFilterTest, FileBasedSpellCheckerTest, 
TestIBSimilarityFactory, TestReplicationHandlerBackup, 
AbstractAnalyticsFacetTest, DebugComponentTest, FieldFacetTest, 
DistributedQueryElevationComponentTest, AbstractAnalyticsStatsTest, 
UpdateRequestProcessorFactoryTest, QueryElevationComponentTest, 
TestNonDefinedSimilarityFactory, TestReRankQParserPlugin, QueryParsingTest, 
LoggingHandlerTest, TestAtomicUpdateErrorCases, StatsComponentTest, 
TestCloudInspectUtil, AutoCommitTest, TestIndexSearcher, SolrIndexConfigTest, 
URLClassifyProcessorTest, CurrencyFieldXmlFileTest, TestCoreContainer, 
DistributedTermsComponentTest, TermVectorComponentDistributedTest, 
SolrRequestParserTest, SuggestComponentTest, TestLazyCores, 
MigrateRouteKeyTest, BasicDistributedZkTest, UnloadDistributedZkTest, 
SyncSliceTest, RecoveryZkTest, TestReplicationHandler]
   [junit4] Completed on J1 in 1035.80s, 13 tests, 1 failure <<< FAILURES!

[...truncated 488 lines...]
BUILD FAILED
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:481:
 The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:454:
 The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:45:
 The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/extra-targets.xml:37:
 The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build.xml:189:
 The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/common-build.xml:496:
 The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:1350:
 The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:965:
 There were test failures: 430 suites, 1782 tests, 1 failure, 52 ignored (9 
assumptions)

Total time: 258 minutes 6 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Sending artifact delta relative to Lucene-Solr-NightlyTests-trunk #605
Archived 3 artifacts
Archive block size is 32768
Received 0 blocks and 523999523 bytes
Compression is 0.0%
Took 1 min 35 sec
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure


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

Reply via email to