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

1 tests failed.
FAILED:  
junit.framework.TestSuite.org.apache.solr.handler.TestReplicationHandler

Error Message:
Resource in scope SUITE failed to close. Resource was registered from thread 
Thread[id=14798, name=coreLoadExecutor-833-thread-1, state=RUNNABLE, 
group=TGRP-TestReplicationHandler], registration stack trace below.

Stack Trace:
com.carrotsearch.randomizedtesting.ResourceDisposalError: Resource in scope 
SUITE failed to close. Resource was registered from thread Thread[id=14798, 
name=coreLoadExecutor-833-thread-1, state=RUNNABLE, 
group=TGRP-TestReplicationHandler], registration stack trace below.
        at __randomizedtesting.SeedInfo.seed([E5E1422D69D18127]:0)
        at java.lang.Thread.getStackTrace(Thread.java:1589)
        at 
com.carrotsearch.randomizedtesting.RandomizedContext.closeAtEnd(RandomizedContext.java:166)
        at 
org.apache.lucene.util.LuceneTestCase.closeAfterSuite(LuceneTestCase.java:726)
        at 
org.apache.lucene.util.LuceneTestCase.wrapDirectory(LuceneTestCase.java:1312)
        at 
org.apache.lucene.util.LuceneTestCase.newDirectory(LuceneTestCase.java:1203)
        at 
org.apache.lucene.util.LuceneTestCase.newDirectory(LuceneTestCase.java:1195)
        at 
org.apache.solr.core.MockDirectoryFactory.create(MockDirectoryFactory.java:47)
        at 
org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:350)
        at org.apache.solr.core.SolrCore.getNewIndexDir(SolrCore.java:276)
        at org.apache.solr.core.SolrCore.initIndex(SolrCore.java:488)
        at org.apache.solr.core.SolrCore.<init>(SolrCore.java:794)
        at org.apache.solr.core.SolrCore.<init>(SolrCore.java:652)
        at org.apache.solr.core.CoreContainer.create(CoreContainer.java:509)
        at org.apache.solr.core.CoreContainer$1.call(CoreContainer.java:273)
        at org.apache.solr.core.CoreContainer$1.call(CoreContainer.java:267)
        at java.util.concurrent.FutureTask.run(FutureTask.java:262)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
        at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.AssertionError: Directory not closed: 
MockDirectoryWrapper(SimpleFSDirectory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/index-SimpleFSDirectory-104
 
lockFactory=NativeFSLockFactory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/index-SimpleFSDirectory-104)
        at org.junit.Assert.fail(Assert.java:93)
        at 
org.apache.lucene.util.CloseableDirectory.close(CloseableDirectory.java:47)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$2$1.apply(RandomizedRunner.java:699)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$2$1.apply(RandomizedRunner.java:696)
        at 
com.carrotsearch.randomizedtesting.RandomizedContext.closeResources(RandomizedContext.java:183)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$2.afterAlways(RandomizedRunner.java:712)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        ... 1 more




Build Log:
[...truncated 11976 lines...]
   [junit4] Suite: org.apache.solr.handler.TestReplicationHandler
   [junit4]   2> Creating dataDir: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/init-core-data-001
   [junit4]   2> 689855 T14232 oas.SolrTestCaseJ4.setUp ###Starting 
doTestStressReplication
   [junit4]   2> 689865 T14232 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 689870 T14232 oejs.AbstractConnector.doStart Started 
SocketConnector@127.0.0.1:45776
   [junit4]   2> 689870 T14232 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()
   [junit4]   2> 689871 T14232 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 689871 T14232 oasc.SolrResourceLoader.locateSolrHome using 
system property solr.solr.home: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001
   [junit4]   2> 689871 T14232 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/'
   [junit4]   2> 689902 T14232 oasc.ConfigSolr.fromFile Loading container 
configuration from 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/solr.xml
   [junit4]   2> 689971 T14232 oasc.CoreContainer.<init> New CoreContainer 
861354553
   [junit4]   2> 689972 T14232 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/]
   [junit4]   2> 689973 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting socketTimeout to: 90000
   [junit4]   2> 689973 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting urlScheme to: 
   [junit4]   2> 689973 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting connTimeout to: 15000
   [junit4]   2> 689973 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnectionsPerHost to: 20
   [junit4]   2> 689974 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnections to: 10000
   [junit4]   2> 689974 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting corePoolSize to: 0
   [junit4]   2> 689974 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting maximumPoolSize to: 2147483647
   [junit4]   2> 689974 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting maxThreadIdleTime to: 5
   [junit4]   2> 689974 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting sizeOfQueue to: -1
   [junit4]   2> 689975 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting fairnessPolicy to: false
   [junit4]   2> 689975 T14232 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=false
   [junit4]   2> 689975 T14232 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 689976 T14232 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 689976 T14232 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 689980 T14242 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/'
   [junit4]   2> 690016 T14242 oasc.SolrConfig.<init> Using Lucene 
MatchVersion: 5.0.0
   [junit4]   2> 690044 T14242 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 690045 T14242 oass.IndexSchema.readSchema Reading Solr Schema 
from schema.xml
   [junit4]   2> 690050 T14242 oass.IndexSchema.readSchema [collection1] Schema 
name=test
   [junit4]   2> 690061 T14242 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 690062 T14242 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from instancedir 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/
   [junit4]   2> 690062 T14242 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 690062 T14242 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/,
 
dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/data/
   [junit4]   2> 690062 T14242 oasc.SolrCore.<init> JMX monitoring not detected 
for core: collection1
   [junit4]   2> 690064 T14242 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/data
   [junit4]   2> 690064 T14242 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/data/index/
   [junit4]   2> 690064 T14242 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 690065 T14242 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/data/index
   [junit4]   2> 690065 T14242 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=46, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=24.7451171875, 
floorSegmentMB=0.572265625, forceMergeDeletesPctAllowed=15.034397429007617, 
segmentsPerTier=14.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.8140521542438667
   [junit4]   2> 690066 T14242 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory(id=lucene-1bbb4055);
 maxCacheMB=0.0166015625 
maxMergeSizeMB=0.31640625)),segFN=segments_1,generation=1}
   [junit4]   2> 690066 T14242 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 690067 T14242 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 690067 T14242 oasc.RequestHandlers.initHandlersFromConfig 
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 690067 T14242 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 690067 T14242 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 690068 T14242 oasc.RequestHandlers.initHandlersFromConfig 
created standard: solr.StandardRequestHandler
   [junit4]   2> 690068 T14242 oasc.RequestHandlers.initHandlersFromConfig 
created /replication: solr.ReplicationHandler
   [junit4]   2> 690068 T14242 oasc.RequestHandlers.initHandlersFromConfig 
created defaults: solr.StandardRequestHandler
   [junit4]   2> 690068 T14242 oasc.RequestHandlers.initHandlersFromConfig 
adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 690068 T14242 oasc.RequestHandlers.initHandlersFromConfig 
created lazy: solr.StandardRequestHandler
   [junit4]   2> 690068 T14242 oasc.RequestHandlers.initHandlersFromConfig 
created /update: solr.UpdateRequestHandler
   [junit4]   2> 690081 T14242 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 690082 T14242 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 690083 T14242 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 690084 T14242 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 690086 T14242 oasu.CommitTracker.<init> Hard AutoCommit: 
disabled
   [junit4]   2> 690086 T14242 oasu.CommitTracker.<init> Soft AutoCommit: 
disabled
   [junit4]   2> 690087 T14242 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=46, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=13.7587890625, 
floorSegmentMB=1.291015625, forceMergeDeletesPctAllowed=8.385171597451274, 
segmentsPerTier=36.0, maxCFSSegmentSizeMB=0.6884765625, noCFSRatio=1.0
   [junit4]   2> 690087 T14242 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory(id=lucene-1bbb4055);
 maxCacheMB=0.0166015625 
maxMergeSizeMB=0.31640625)),segFN=segments_1,generation=1}
   [junit4]   2> 690087 T14242 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 690087 T14242 oass.SolrIndexSearcher.<init> Opening 
Searcher@41723f76[collection1] main
   [junit4]   2> 690088 T14242 
oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage 
initialized to use dir: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/conf
   [junit4]   2> 690088 T14242 oasr.RestManager.init Initializing RestManager 
with initArgs: 
{storageDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/conf}
   [junit4]   2> 690088 T14242 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using 
file:dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/conf
   [junit4]   2> 690089 T14242 oasr.ManagedResource.reloadFromStorage WARN No 
stored data found for /rest/managed
   [junit4]   2> 690089 T14242 oasr.ManagedResourceStorage$JsonStorage.store 
Saved JSON object to path _rest_managed.json using 
file:dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/conf
   [junit4]   2> 690089 T14242 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 690090 T14242 oash.ReplicationHandler.inform Replication 
enabled for following config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 690090 T14242 oash.ReplicationHandler.inform Commits will be 
reserved for  10000
   [junit4]   2> 690090 T14242 oasc.CoreContainer.registerCore registering 
core: collection1
   [junit4]   2> 690090 T14243 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@41723f76[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 690090 T14232 oass.SolrDispatchFilter.init 
user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2
   [junit4]   2> 690091 T14232 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init() done
   [junit4]   2> 690098 T14232 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 690100 T14232 oejs.AbstractConnector.doStart Started 
SocketConnector@127.0.0.1:31975
   [junit4]   2> 690101 T14232 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()
   [junit4]   2> 690101 T14232 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 690101 T14232 oasc.SolrResourceLoader.locateSolrHome using 
system property solr.solr.home: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002
   [junit4]   2> 690101 T14232 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/'
   [junit4]   2> 690113 T14232 oasc.ConfigSolr.fromFile Loading container 
configuration from 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/solr.xml
   [junit4]   2> 690161 T14232 oasc.CoreContainer.<init> New CoreContainer 
1266661740
   [junit4]   2> 690161 T14232 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/]
   [junit4]   2> 690163 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting socketTimeout to: 90000
   [junit4]   2> 690163 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting urlScheme to: 
   [junit4]   2> 690163 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting connTimeout to: 15000
   [junit4]   2> 690164 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnectionsPerHost to: 20
   [junit4]   2> 690164 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnections to: 10000
   [junit4]   2> 690164 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting corePoolSize to: 0
   [junit4]   2> 690165 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting maximumPoolSize to: 2147483647
   [junit4]   2> 690165 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting maxThreadIdleTime to: 5
   [junit4]   2> 690165 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting sizeOfQueue to: -1
   [junit4]   2> 690166 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting fairnessPolicy to: false
   [junit4]   2> 690166 T14232 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=false
   [junit4]   2> 690167 T14232 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 690167 T14232 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 690168 T14232 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 690173 T14254 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/'
   [junit4]   2> 690221 T14254 oasc.SolrConfig.<init> Using Lucene 
MatchVersion: 5.0.0
   [junit4]   2> 690264 T14254 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 690265 T14254 oass.IndexSchema.readSchema Reading Solr Schema 
from schema.xml
   [junit4]   2> 690272 T14254 oass.IndexSchema.readSchema [collection1] Schema 
name=test
   [junit4]   2> 690286 T14254 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 690287 T14254 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from instancedir 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/
   [junit4]   2> 690287 T14254 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 690288 T14254 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/,
 
dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/data/
   [junit4]   2> 690288 T14254 oasc.SolrCore.<init> JMX monitoring not detected 
for core: collection1
   [junit4]   2> 690290 T14254 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/data
   [junit4]   2> 690291 T14254 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/data/index/
   [junit4]   2> 690291 T14254 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 690292 T14254 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/data/index
   [junit4]   2> 690293 T14254 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=46, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=24.7451171875, 
floorSegmentMB=0.572265625, forceMergeDeletesPctAllowed=15.034397429007617, 
segmentsPerTier=14.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.8140521542438667
   [junit4]   2> 690294 T14254 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory(id=lucene-98ca0db);
 maxCacheMB=0.0166015625 
maxMergeSizeMB=0.31640625)),segFN=segments_1,generation=1}
   [junit4]   2> 690294 T14254 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 690295 T14254 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 690296 T14254 oasc.RequestHandlers.initHandlersFromConfig 
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 690296 T14254 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 690296 T14254 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 690296 T14254 oasc.RequestHandlers.initHandlersFromConfig 
created standard: solr.StandardRequestHandler
   [junit4]   2> 690297 T14254 oasc.RequestHandlers.initHandlersFromConfig 
created defaults: solr.StandardRequestHandler
   [junit4]   2> 690297 T14254 oasc.RequestHandlers.initHandlersFromConfig 
adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 690297 T14254 oasc.RequestHandlers.initHandlersFromConfig 
created lazy: solr.StandardRequestHandler
   [junit4]   2> 690297 T14254 oasc.RequestHandlers.initHandlersFromConfig 
created /update: solr.UpdateRequestHandler
   [junit4]   2> 690298 T14254 oasc.RequestHandlers.initHandlersFromConfig 
created /replication: solr.ReplicationHandler
   [junit4]   2> 690300 T14254 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 690302 T14254 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 690304 T14254 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 690307 T14254 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 690309 T14254 oasu.CommitTracker.<init> Hard AutoCommit: 
disabled
   [junit4]   2> 690309 T14254 oasu.CommitTracker.<init> Soft AutoCommit: 
disabled
   [junit4]   2> 690310 T14254 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=46, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=13.7587890625, 
floorSegmentMB=1.291015625, forceMergeDeletesPctAllowed=8.385171597451274, 
segmentsPerTier=36.0, maxCFSSegmentSizeMB=0.6884765625, noCFSRatio=1.0
   [junit4]   2> 690310 T14254 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory(id=lucene-98ca0db);
 maxCacheMB=0.0166015625 
maxMergeSizeMB=0.31640625)),segFN=segments_1,generation=1}
   [junit4]   2> 690311 T14254 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 690311 T14254 oass.SolrIndexSearcher.<init> Opening 
Searcher@4f70db7d[collection1] main
   [junit4]   2> 690312 T14254 
oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage 
initialized to use dir: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/conf
   [junit4]   2> 690312 T14254 oasr.RestManager.init Initializing RestManager 
with initArgs: 
{storageDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/conf}
   [junit4]   2> 690312 T14254 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using 
file:dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/conf
   [junit4]   2> 690313 T14254 oasr.ManagedResource.reloadFromStorage WARN No 
stored data found for /rest/managed
   [junit4]   2> 690314 T14254 oasr.ManagedResourceStorage$JsonStorage.store 
Saved JSON object to path _rest_managed.json using 
file:dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/conf
   [junit4]   2> 690314 T14254 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 690321 T14254 oash.SnapPuller.startExecutorService Poll 
Scheduled at an interval of 1000ms
   [junit4]   2> 690321 T14255 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@4f70db7d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 690321 T14254 oasc.CoreContainer.registerCore registering 
core: collection1
   [junit4]   2> 690322 T14232 oass.SolrDispatchFilter.init 
user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2
   [junit4]   2> 690322 T14232 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init() done
   [junit4]   2> 690327 T14232 oasc.CoreContainer.shutdown Shutting down 
CoreContainer instance=1266661740
   [junit4]   2> 690328 T14232 oasc.SolrCore.close [collection1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@639b9ef8
   [junit4]   2> 690329 T14232 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> 690330 T14232 oasu.SolrCoreState.decrefSolrCoreState Closing 
SolrCoreState
   [junit4]   2> 690330 T14232 oasu.DefaultSolrCoreState.closeIndexWriter 
SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 690330 T14232 oasu.DefaultSolrCoreState.closeIndexWriter 
closing IndexWriter with IndexWriterCloser
   [junit4]   2> 690332 T14232 oasc.SolrCore.closeSearcher [collection1] 
Closing main searcher on request.
   [junit4]   2> 690332 T14232 oasc.CachingDirectoryFactory.close Closing 
MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 690333 T14232 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/data
 
[CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/data;done=false>>]
   [junit4]   2> 690333 T14232 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/data
   [junit4]   2> 690333 T14232 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/data/index
 
[CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/data/index;done=false>>]
   [junit4]   2> 690334 T14232 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/data/index
   [junit4]   2> 690335 T14232 oejsh.ContextHandler.doStop stopped 
o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 695104 T14232 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 695108 T14232 oejs.AbstractConnector.doStart Started 
SocketConnector@127.0.0.1:39478
   [junit4]   2> 695109 T14232 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()
   [junit4]   2> 695109 T14232 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 695110 T14232 oasc.SolrResourceLoader.locateSolrHome using 
system property solr.solr.home: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002
   [junit4]   2> 695110 T14232 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/'
   [junit4]   2> 695135 T14232 oasc.ConfigSolr.fromFile Loading container 
configuration from 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/solr.xml
   [junit4]   2> 695194 T14232 oasc.CoreContainer.<init> New CoreContainer 
654080899
   [junit4]   2> 695195 T14232 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/]
   [junit4]   2> 695197 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting socketTimeout to: 90000
   [junit4]   2> 695197 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting urlScheme to: 
   [junit4]   2> 695198 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting connTimeout to: 15000
   [junit4]   2> 695198 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnectionsPerHost to: 20
   [junit4]   2> 695199 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnections to: 10000
   [junit4]   2> 695199 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting corePoolSize to: 0
   [junit4]   2> 695200 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting maximumPoolSize to: 2147483647
   [junit4]   2> 695200 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting maxThreadIdleTime to: 5
   [junit4]   2> 695201 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting sizeOfQueue to: -1
   [junit4]   2> 695201 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting fairnessPolicy to: false
   [junit4]   2> 695202 T14232 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=false
   [junit4]   2> 695203 T14232 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 695203 T14232 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 695203 T14232 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 695209 T14267 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/'
   [junit4]   2> 695256 T14267 oasc.SolrConfig.<init> Using Lucene 
MatchVersion: 5.0.0
   [junit4]   2> 695302 T14267 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 695303 T14267 oass.IndexSchema.readSchema Reading Solr Schema 
from schema.xml
   [junit4]   2> 695311 T14267 oass.IndexSchema.readSchema [collection1] Schema 
name=test
   [junit4]   2> 695325 T14267 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 695326 T14267 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from instancedir 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/
   [junit4]   2> 695326 T14267 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 695327 T14267 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/,
 
dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/data/
   [junit4]   2> 695327 T14267 oasc.SolrCore.<init> JMX monitoring not detected 
for core: collection1
   [junit4]   2> 695329 T14267 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/data
   [junit4]   2> 695330 T14267 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/data/index/
   [junit4]   2> 695330 T14267 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 695331 T14267 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/data/index
   [junit4]   2> 695332 T14267 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=46, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=24.7451171875, 
floorSegmentMB=0.572265625, forceMergeDeletesPctAllowed=15.034397429007617, 
segmentsPerTier=14.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.8140521542438667
   [junit4]   2> 695352 T14267 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory(id=lucene-20ae0710);
 maxCacheMB=0.0166015625 
maxMergeSizeMB=0.31640625)),segFN=segments_1,generation=1}
   [junit4]   2> 695353 T14267 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 695354 T14267 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 695354 T14267 oasc.RequestHandlers.initHandlersFromConfig 
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 695355 T14267 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 695355 T14267 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 695355 T14267 oasc.RequestHandlers.initHandlersFromConfig 
created standard: solr.StandardRequestHandler
   [junit4]   2> 695355 T14267 oasc.RequestHandlers.initHandlersFromConfig 
created defaults: solr.StandardRequestHandler
   [junit4]   2> 695356 T14267 oasc.RequestHandlers.initHandlersFromConfig 
adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 695356 T14267 oasc.RequestHandlers.initHandlersFromConfig 
created lazy: solr.StandardRequestHandler
   [junit4]   2> 695356 T14267 oasc.RequestHandlers.initHandlersFromConfig 
created /update: solr.UpdateRequestHandler
   [junit4]   2> 695356 T14267 oasc.RequestHandlers.initHandlersFromConfig 
created /replication: solr.ReplicationHandler
   [junit4]   2> 695359 T14267 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 695361 T14267 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 695363 T14267 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 695365 T14267 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 695367 T14267 oasu.CommitTracker.<init> Hard AutoCommit: 
disabled
   [junit4]   2> 695367 T14267 oasu.CommitTracker.<init> Soft AutoCommit: 
disabled
   [junit4]   2> 695368 T14267 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=46, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=13.7587890625, 
floorSegmentMB=1.291015625, forceMergeDeletesPctAllowed=8.385171597451274, 
segmentsPerTier=36.0, maxCFSSegmentSizeMB=0.6884765625, noCFSRatio=1.0
   [junit4]   2> 695369 T14267 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory(id=lucene-20ae0710);
 maxCacheMB=0.0166015625 
maxMergeSizeMB=0.31640625)),segFN=segments_1,generation=1}
   [junit4]   2> 695369 T14267 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 695369 T14267 oass.SolrIndexSearcher.<init> Opening 
Searcher@b5edae0[collection1] main
   [junit4]   2> 695370 T14267 
oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage 
initialized to use dir: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/conf
   [junit4]   2> 695370 T14267 oasr.RestManager.init Initializing RestManager 
with initArgs: 
{storageDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/conf}
   [junit4]   2> 695370 T14267 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using 
file:dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/conf
   [junit4]   2> 695371 T14267 oasr.ManagedResourceStorage.load Loaded 
LinkedHashMap at path _rest_managed.json using 
file:dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/conf
   [junit4]   2> 695371 T14267 oasr.ManagedResource.reloadFromStorage Loaded 
initArgs {} for /rest/managed
   [junit4]   2> 695371 T14267 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 695372 T14267 oash.ReplicationHandler.inform Commits will be 
reserved for  10000
   [junit4]   2> 695372 T14268 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@b5edae0[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 695372 T14267 oasc.CoreContainer.registerCore registering 
core: collection1
   [junit4]   2> 695373 T14232 oass.SolrDispatchFilter.init 
user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2
   [junit4]   2> 695373 T14232 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init() done
   [junit4]   2> 695377 T14232 oasc.CoreContainer.shutdown Shutting down 
CoreContainer instance=861354553
   [junit4]   2> 695378 T14232 oasc.SolrCore.close [collection1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@5df7c28
   [junit4]   2> 695379 T14232 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> 695379 T14232 oasu.SolrCoreState.decrefSolrCoreState Closing 
SolrCoreState
   [junit4]   2> 695380 T14232 oasu.DefaultSolrCoreState.closeIndexWriter 
SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 695380 T14232 oasu.DefaultSolrCoreState.closeIndexWriter 
closing IndexWriter with IndexWriterCloser
   [junit4]   2> 695382 T14232 oasc.SolrCore.closeSearcher [collection1] 
Closing main searcher on request.
   [junit4]   2> 695382 T14232 oasc.CachingDirectoryFactory.close Closing 
MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 695383 T14232 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/data
 
[CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/data;done=false>>]
   [junit4]   2> 695383 T14232 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/data
   [junit4]   2> 695383 T14232 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/data/index
 
[CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/data/index;done=false>>]
   [junit4]   2> 695384 T14232 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/data/index
   [junit4]   2> 695385 T14232 oejsh.ContextHandler.doStop stopped 
o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 699872 T14232 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 699875 T14232 oejs.AbstractConnector.doStart Started 
SocketConnector@127.0.0.1:42807
   [junit4]   2> 699876 T14232 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()
   [junit4]   2> 699876 T14232 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 699876 T14232 oasc.SolrResourceLoader.locateSolrHome using 
system property solr.solr.home: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001
   [junit4]   2> 699877 T14232 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/'
   [junit4]   2> 699894 T14232 oasc.ConfigSolr.fromFile Loading container 
configuration from 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/solr.xml
   [junit4]   2> 699939 T14232 oasc.CoreContainer.<init> New CoreContainer 
1068964121
   [junit4]   2> 699940 T14232 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/]
   [junit4]   2> 699941 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting socketTimeout to: 90000
   [junit4]   2> 699941 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting urlScheme to: 
   [junit4]   2> 699942 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting connTimeout to: 15000
   [junit4]   2> 699942 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnectionsPerHost to: 20
   [junit4]   2> 699942 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnections to: 10000
   [junit4]   2> 699943 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting corePoolSize to: 0
   [junit4]   2> 699943 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting maximumPoolSize to: 2147483647
   [junit4]   2> 699943 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting maxThreadIdleTime to: 5
   [junit4]   2> 699944 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting sizeOfQueue to: -1
   [junit4]   2> 699944 T14232 oashc.HttpShardHandlerFactory.getParameter 
Setting fairnessPolicy to: false
   [junit4]   2> 699945 T14232 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=false
   [junit4]   2> 699945 T14232 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 699945 T14232 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 699946 T14232 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 699950 T14279 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/'
   [junit4]   2> 699997 T14279 oasc.SolrConfig.<init> Using Lucene 
MatchVersion: 5.0.0
   [junit4]   2> 700038 T14279 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 700039 T14279 oass.IndexSchema.readSchema Reading Solr Schema 
from schema.xml
   [junit4]   2> 700046 T14279 oass.IndexSchema.readSchema [collection1] Schema 
name=test
   [junit4]   2> 700058 T14279 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 700059 T14279 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from instancedir 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/
   [junit4]   2> 700059 T14279 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 700059 T14279 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/,
 
dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/data/
   [junit4]   2> 700059 T14279 oasc.SolrCore.<init> JMX monitoring not detected 
for core: collection1
   [junit4]   2> 700062 T14279 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/data
   [junit4]   2> 700063 T14279 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/data/index/
   [junit4]   2> 700063 T14279 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 700064 T14279 oasc.CachingDirectoryFactory.get return new 
directory for 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/data/index
   [junit4]   2> 700064 T14279 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=46, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=24.7451171875, 
floorSegmentMB=0.572265625, forceMergeDeletesPctAllowed=15.034397429007617, 
segmentsPerTier=14.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.8140521542438667
   [junit4]   2> 700065 T14279 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory(id=lucene-1d36fd0f);
 maxCacheMB=0.0166015625 
maxMergeSizeMB=0.31640625)),segFN=segments_1,generation=1}
   [junit4]   2> 700065 T14279 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 700067 T14279 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 700067 T14279 oasc.RequestHandlers.initHandlersFromConfig 
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 700067 T14279 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 700068 T14279 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 700068 T14279 oasc.RequestHandlers.initHandlersFromConfig 
created standard: solr.StandardRequestHandler
   [junit4]   2> 700069 T14279 oasc.RequestHandlers.initHandlersFromConfig 
created /replication: solr.ReplicationHandler
   [junit4]   2> 700069 T14279 oasc.RequestHandlers.initHandlersFromConfig 
created defaults: solr.StandardRequestHandler
   [junit4]   2> 700069 T14279 oasc.RequestHandlers.initHandlersFromConfig 
adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 700069 T14279 oasc.RequestHandlers.initHandlersFromConfig 
created lazy: solr.StandardRequestHandler
   [junit4]   2> 700070 T14279 oasc.RequestHandlers.initHandlersFromConfig 
created /update: solr.UpdateRequestHandler
   [junit4]   2> 700072 T14279 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 700074 T14279 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 700076 T14279 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 700078 T14279 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 700080 T14279 oasu.CommitTracker.<init> Hard AutoCommit: 
disabled
   [junit4]   2> 700080 T14279 oasu.CommitTracker.<init> Soft AutoCommit: 
disabled
   [junit4]   2> 700081 T14279 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=46, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=13.7587890625, 
floorSegmentMB=1.291015625, forceMergeDeletesPctAllowed=8.385171597451274, 
segmentsPerTier=36.0, maxCFSSegmentSizeMB=0.6884765625, noCFSRatio=1.0
   [junit4]   2> 700081 T14279 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory(id=lucene-1d36fd0f);
 maxCacheMB=0.0166015625 
maxMergeSizeMB=0.31640625)),segFN=segments_1,generation=1}
   [junit4]   2> 700082 T14279 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 700082 T14279 oass.SolrIndexSearcher.<init> Opening 
Searcher@73f056f8[collection1] main
   [junit4]   2> 700083 T14279 
oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage 
initialized to use dir: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/conf
   [junit4]   2> 700083 T14279 oasr.RestManager.init Initializing RestManager 
with initArgs: 
{storageDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/conf}
   [junit4]   2> 700083 T14279 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using 
file:dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/conf
   [junit4]   2> 700084 T14279 oasr.ManagedResourceStorage.load Loaded 
LinkedHashMap at path _rest_managed.json using 
file:dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-001/collection1/conf
   [junit4]   2> 700084 T14279 oasr.ManagedResource.reloadFromStorage Loaded 
initArgs {} for /rest/managed
   [junit4]   2> 700084 T14279 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 700084 T14279 oash.ReplicationHandler.inform Replication 
enabled for following config files: schema.xml
   [junit4]   2> 700085 T14279 oash.ReplicationHandler.inform Commits will be 
reserved for  10000
   [junit4]   2> 700085 T14280 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@73f056f8[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 700085 T14279 oasc.CoreContainer.registerCore registering 
core: collection1
   [junit4]   2> 700086 T14232 oass.SolrDispatchFilter.init 
user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2
   [junit4]   2> 700086 T14232 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init() done
   [junit4]   2> ASYNC  NEW_CORE C406 name=collection1 
org.apache.solr.core.SolrCore@1f8774aa
   [junit4]   2> 700089 T14272 C406 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 700090 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{deleteByQuery=*:*} 0 1
   [junit4]   2> ASYNC  NEW_CORE C407 name=collection1 
org.apache.solr.core.SolrCore@6484f95c
   [junit4]   2> 700092 T14260 C407 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 700092 T14260 C407 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{deleteByQuery=*:*} 0 0
   [junit4]   2> 700095 T14260 C407 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 700096 T14260 C407 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory(id=lucene-20ae0710);
 maxCacheMB=0.0166015625 
maxMergeSizeMB=0.31640625)),segFN=segments_1,generation=1}
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory(id=lucene-20ae0710);
 maxCacheMB=0.0166015625 
maxMergeSizeMB=0.31640625)),segFN=segments_2,generation=2}
   [junit4]   2> 700096 T14260 C407 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 2
   [junit4]   2> 700098 T14260 C407 oass.SolrIndexSearcher.<init> Opening 
Searcher@30c8de40[collection1] main
   [junit4]   2> 700099 T14260 C407 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 700099 T14268 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@30c8de40[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 700099 T14260 C407 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update 
params={softCommit=false&wt=javabin&version=2&waitSearcher=true&commit=true} 
{commit=} 0 4
   [junit4]   2> 700106 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0]} 
0 1
   [junit4]   2> 700109 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1]} 
0 0
   [junit4]   2> 700112 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2]} 
0 0
   [junit4]   2> 700115 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[3]} 
0 0
   [junit4]   2> 700118 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[4]} 
0 0
   [junit4]   2> 700121 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[5]} 
0 0
   [junit4]   2> 700124 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[6]} 
0 0
   [junit4]   2> 700127 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[7]} 
0 0
   [junit4]   2> 700130 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[8]} 
0 0
   [junit4]   2> 700133 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[9]} 
0 0
   [junit4]   2> 700136 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[10]} 0 0
   [junit4]   2> 700139 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[11]} 0 0
   [junit4]   2> 700142 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[12]} 0 0
   [junit4]   2> 700145 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[13]} 0 0
   [junit4]   2> 700148 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[14]} 0 0
   [junit4]   2> 700151 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[15]} 0 0
   [junit4]   2> 700154 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[16]} 0 0
   [junit4]   2> 700157 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[17]} 0 0
   [junit4]   2> 700160 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[18]} 0 0
   [junit4]   2> 700163 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[19]} 0 0
   [junit4]   2> 700166 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[20]} 0 0
   [junit4]   2> 700169 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[21]} 0 0
   [junit4]   2> 700172 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[22]} 0 0
   [junit4]   2> 700175 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[23]} 0 0
   [junit4]   2> 700178 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[24]} 0 0
   [junit4]   2> 700181 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[25]} 0 0
   [junit4]   2> 700184 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[26]} 0 0
   [junit4]   2> 700187 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[27]} 0 0
   [junit4]   2> 700190 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[28]} 0 0
   [junit4]   2> 700193 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[29]} 0 0
   [junit4]   2> 700196 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[30]} 0 0
   [junit4]   2> 700199 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[31]} 0 0
   [junit4]   2> 700202 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[32]} 0 0
   [junit4]   2> 700205 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[33]} 0 0
   [junit4]   2> 700208 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[34]} 0 0
   [junit4]   2> 700211 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[35]} 0 0
   [junit4]   2> 700214 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[36]} 0 0
   [junit4]   2> 700217 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[37]} 0 0
   [junit4]   2> 700220 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[38]} 0 0
   [junit4]   2> 700223 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[39]} 0 0
   [junit4]   2> 700226 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[40]} 0 0
   [junit4]   2> 700229 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[41]} 0 0
   [junit4]   2> 700232 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[42]} 0 0
   [junit4]   2> 700235 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[43]} 0 0
   [junit4]   2> 700238 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[44]} 0 0
   [junit4]   2> 700242 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[45]} 0 0
   [junit4]   2> 700245 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[46]} 0 0
   [junit4]   2> 700248 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[47]} 0 0
   [junit4]   2> 700251 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[48]} 0 0
   [junit4]   2> 700254 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[49]} 0 0
   [junit4]   2> 700257 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[50]} 0 0
   [junit4]   2> 700260 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[51]} 0 0
   [junit4]   2> 700263 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[52]} 0 0
   [junit4]   2> 700266 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[53]} 0 0
   [junit4]   2> 700269 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[54]} 0 0
   [junit4]   2> 700272 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[55]} 0 0
   [junit4]   2> 700275 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[56]} 0 0
   [junit4]   2> 700278 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[57]} 0 0
   [junit4]   2> 700281 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[58]} 0 0
   [junit4]   2> 700284 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[59]} 0 0
   [junit4]   2> 700287 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[60]} 0 0
   [junit4]   2> 700290 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[61]} 0 0
   [junit4]   2> 700293 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[62]} 0 0
   [junit4]   2> 700296 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[63]} 0 0
   [junit4]   2> 700299 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[64]} 0 0
   [junit4]   2> 700302 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[65]} 0 0
   [junit4]   2> 700305 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[66]} 0 0
   [junit4]   2> 700308 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[67]} 0 0
   [junit4]   2> 700311 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[68]} 0 0
   [junit4]   2> 700314 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[69]} 0 0
   [junit4]   2> 700317 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[70]} 0 0
   [junit4]   2> 700320 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[71]} 0 0
   [junit4]   2> 700323 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[72]} 0 0
   [junit4]   2> 700326 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[73]} 0 0
   [junit4]   2> 700329 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[74]} 0 0
   [junit4]   2> 700332 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[75]} 0 0
   [junit4]   2> 700335 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[76]} 0 0
   [junit4]   2> 700338 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[77]} 0 0
   [junit4]   2> 700341 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[78]} 0 0
   [junit4]   2> 700344 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[79]} 0 0
   [junit4]   2> 700347 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[80]} 0 0
   [junit4]   2> 700350 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[81]} 0 0
   [junit4]   2> 700353 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[82]} 0 0
   [junit4]   2> 700356 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[83]} 0 0
   [junit4]   2> 700359 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[84]} 0 0
   [junit4]   2> 700362 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[85]} 0 0
   [junit4]   2> 700365 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[86]} 0 0
   [junit4]   2> 700368 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[87]} 0 0
   [junit4]   2> 700371 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[88]} 0 0
   [junit4]   2> 700374 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[89]} 0 0
   [junit4]   2> 700377 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[90]} 0 0
   [junit4]   2> 700380 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[91]} 0 0
   [junit4]   2> 700383 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[92]} 0 0
   [junit4]   2> 700386 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[93]} 0 0
   [junit4]   2> 700389 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[94]} 0 0
   [junit4]   2> 700392 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[95]} 0 0
   [junit4]   2> 700395 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[96]} 0 0
   [junit4]   2> 700398 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[97]} 0 0
   [junit4]   2> 700401 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[98]} 0 0
   [junit4]   2> 700404 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[99]} 0 0
   [junit4]   2> 700407 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[100]} 0 0
   [junit4]   2> 700410 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[101]} 0 0
   [junit4]   2> 700413 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[102]} 0 0
   [junit4]   2> 700416 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[103]} 0 0
   [junit4]   2> 700419 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[104]} 0 0
   [junit4]   2> 700422 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[105]} 0 0
   [junit4]   2> 700425 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[106]} 0 0
   [junit4]   2> 700428 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[107]} 0 0
   [junit4]   2> 700431 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[108]} 0 0
   [junit4]   2> 700434 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[109]} 0 0
   [junit4]   2> 700437 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[110]} 0 0
   [junit4]   2> 700440 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[111]} 0 0
   [junit4]   2> 700443 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[112]} 0 0
   [junit4]   2> 700446 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[113]} 0 0
   [junit4]   2> 700449 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[114]} 0 0
   [junit4]   2> 700452 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[115]} 0 0
   [junit4]   2> 700455 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[116]} 0 0
   [junit4]   2> 700458 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[117]} 0 0
   [junit4]   2> 700461 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[118]} 0 0
   [junit4]   2> 700464 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[119]} 0 0
   [junit4]   2> 700467 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[120]} 0 0
   [junit4]   2> 700470 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[121]} 0 0
   [junit4]   2> 700473 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[122]} 0 0
   [junit4]   2> 700476 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[123]} 0 0
   [junit4]   2> 700479 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[124]} 0 0
   [junit4]   2> 700482 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[125]} 0 0
   [junit4]   2> 700485 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[126]} 0 0
   [junit4]   2> 700488 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[127]} 0 0
   [junit4]   2> 700491 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[128]} 0 0
   [junit4]   2> 700494 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[129]} 0 0
   [junit4]   2> 700497 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[130]} 0 0
   [junit4]   2> 700500 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[131]} 0 0
   [junit4]   2> 700503 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[132]} 0 0
   [junit4]   2> 700506 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[133]} 0 0
   [junit4]   2> 700509 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[134]} 0 0
   [junit4]   2> 700512 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[135]} 0 0
   [junit4]   2> 700515 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[136]} 0 0
   [junit4]   2> 700518 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[137]} 0 0
   [junit4]   2> 700521 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[138]} 0 0
   [junit4]   2> 700524 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[139]} 0 0
   [junit4]   2> 700527 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[140]} 0 0
   [junit4]   2> 700530 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[141]} 0 0
   [junit4]   2> 700533 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[142]} 0 0
   [junit4]   2> 700536 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[143]} 0 0
   [junit4]   2> 700539 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[144]} 0 0
   [junit4]   2> 700542 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[145]} 0 0
   [junit4]   2> 700545 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[146]} 0 0
   [junit4]   2> 700548 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[147]} 0 0
   [junit4]   2> 700551 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[148]} 0 0
   [junit4]   2> 700555 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[149]} 0 0
   [junit4]   2> 700558 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[150]} 0 0
   [junit4]   2> 700561 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[151]} 0 0
   [junit4]   2> 700564 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[152]} 0 0
   [junit4]   2> 700567 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[153]} 0 0
   [junit4]   2> 700570 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[154]} 0 0
   [junit4]   2> 700573 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[155]} 0 0
   [junit4]   2> 700576 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[156]} 0 0
   [junit4]   2> 700579 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[157]} 0 0
   [junit4]   2> 700582 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[158]} 0 0
   [junit4]   2> 700585 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[159]} 0 0
   [junit4]   2> 700588 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[160]} 0 0
   [junit4]   2> 700591 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[161]} 0 0
   [junit4]   2> 700594 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[162]} 0 0
   [junit4]   2> 700597 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[163]} 0 0
   [junit4]   2> 700600 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[164]} 0 0
   [junit4]   2> 700603 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[165]} 0 0
   [junit4]   2> 700606 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[166]} 0 0
   [junit4]   2> 700609 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[167]} 0 0
   [junit4]   2> 700612 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[168]} 0 0
   [junit4]   2> 700615 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[169]} 0 0
   [junit4]   2> 700618 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[170]} 0 0
   [junit4]   2> 700621 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[171]} 0 0
   [junit4]   2> 700624 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[172]} 0 0
   [junit4]   2> 700627 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[173]} 0 0
   [junit4]   2> 700630 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[174]} 0 0
   [junit4]   2> 700633 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[175]} 0 0
   [junit4]   2> 700636 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[176]} 0 0
   [junit4]   2> 700639 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[177]} 0 0
   [junit4]   2> 700642 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[178]} 0 0
   [junit4]   2> 700645 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[179]} 0 0
   [junit4]   2> 700648 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[180]} 0 0
   [junit4]   2> 700651 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[181]} 0 0
   [junit4]   2> 700654 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[182]} 0 0
   [junit4]   2> 700657 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[183]} 0 0
   [junit4]   2> 700660 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[184]} 0 0
   [junit4]   2> 700663 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[185]} 0 0
   [junit4]   2> 700666 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[186]} 0 0
   [junit4]   2> 700669 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[187]} 0 0
   [junit4]   2> 700672 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[188]} 0 0
   [junit4]   2> 700675 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[189]} 0 0
   [junit4]   2> 700678 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[190]} 0 0
   [junit4]   2> 700681 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[191]} 0 0
   [junit4]   2> 700684 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[192]} 0 0
   [junit4]   2> 700687 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[193]} 0 0
   [junit4]   2> 700690 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[194]} 0 0
   [junit4]   2> 700693 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[195]} 0 0
   [junit4]   2> 700696 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[196]} 0 0
   [junit4]   2> 700699 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[197]} 0 0
   [junit4]   2> 700702 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[198]} 0 0
   [junit4]   2> 700705 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[199]} 0 0
   [junit4]   2> 700708 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[200]} 0 0
   [junit4]   2> 700711 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[201]} 0 0
   [junit4]   2> 700714 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path=/update params={wt=javabin&version=2} 
{add=[202]} 0 0
   [junit4]   2> 700717 T14272 C406 oasup.LogUpdateProcessor.finish 
[collection1] webapp=/solr path

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


   [junit4]   2>                at 
java.util.concurrent.FutureTask.runAndReset(FutureTask.java:304)
   [junit4]   2>                at 
java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:178)
   [junit4]   2>                at 
java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
   [junit4]   2>                at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
   [junit4]   2>                at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
   [junit4]   2>                at java.lang.Thread.run(Thread.java:745)
   [junit4]   2>        Caused by: java.nio.channels.ClosedByInterruptException
   [junit4]   2>                at 
java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:202)
   [junit4]   2>                at 
sun.nio.ch.FileChannelImpl.size(FileChannelImpl.java:312)
   [junit4]   2>                at 
org.apache.lucene.store.MMapDirectory.openInput(MMapDirectory.java:199)
   [junit4]   2>                at 
org.apache.solr.handler.ReplicationHandler.loadReplicationProperties(ReplicationHandler.java:826)
   [junit4]   2>                ... 11 more
   [junit4]   2>        
   [junit4]   2> 1736981 T14232 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> 1736981 T14232 oasu.SolrCoreState.decrefSolrCoreState Closing 
SolrCoreState
   [junit4]   2> 1736982 T14232 oasu.DefaultSolrCoreState.closeIndexWriter 
SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 1736983 T14232 oasu.DefaultSolrCoreState.closeIndexWriter 
closing IndexWriter with IndexWriterCloser
   [junit4]   2> 1736983 T14232 oasc.SolrCore.closeSearcher [collection1] 
Closing main searcher on request.
   [junit4]   2> 1736984 T14232 oasc.CachingDirectoryFactory.close Closing 
StandardDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 1736984 T14232 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/data/index
 
[CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/data/index;done=false>>]
   [junit4]   2> 1736985 T14232 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/data/index
   [junit4]   2> 1736985 T14232 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/data
 
[CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/data;done=false>>]
   [junit4]   2> 1736986 T14232 oasc.CachingDirectoryFactory.close Closing 
directory: 
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/solr-instance-002/collection1/data
   [junit4]   2> 1736986 T14232 oejsh.ContextHandler.doStop stopped 
o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 1741399 T14232 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene50): 
{newname=PostingsFormat(name=Lucene41VarGapFixedInterval), 
name=PostingsFormat(name=Lucene41VarGapFixedInterval), 
id=PostingsFormat(name=Lucene41VarGapFixedInterval)}, docValues:{}, 
sim=DefaultSimilarity, locale=es_UY, timezone=Navajo
   [junit4]   2> NOTE: FreeBSD 9.1-RELEASE-p3 amd64/Oracle Corporation 1.7.0_65 
(64-bit)/cpus=16,threads=1,free=224715448,total=463994880
   [junit4]   2> NOTE: All tests run in this JVM: [HighlighterConfigTest, 
TestIndexingPerformance, AssignTest, HdfsUnloadDistributedZkTest, 
TestLuceneMatchVersion, LeaderElectionIntegrationTest, RAMDirectoryFactoryTest, 
DistributedFacetPivotLongTailTest, TestShortCircuitedRequests, 
TestStressRecovery, HighlighterTest, TestFieldTypeResource, 
CollectionsAPIAsyncDistributedZkTest, TestUpdate, TestDistributedSearch, 
TestMissingGroups, TestManagedResourceStorage, TestSolr4Spatial, 
TestCharFilters, TestReplicaProperties, TestReplicationHandler]
   [junit4]   2> NOTE: download the large Jenkins line-docs file by running 
'ant get-jenkins-line-docs' in the lucene directory.
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestReplicationHandler -Dtests.seed=E5E1422D69D18127 
-Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true 
-Dtests.linedocsfile=/home/jenkins/lucene-data/enwiki.random.lines.txt 
-Dtests.locale=es_UY -Dtests.timezone=Navajo -Dtests.file.encoding=US-ASCII
   [junit4] ERROR   0.00s J2 | TestReplicationHandler (suite) <<<
   [junit4]    > Throwable #1: 
com.carrotsearch.randomizedtesting.ResourceDisposalError: Resource in scope 
SUITE failed to close. Resource was registered from thread Thread[id=14798, 
name=coreLoadExecutor-833-thread-1, state=RUNNABLE, 
group=TGRP-TestReplicationHandler], registration stack trace below.
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([E5E1422D69D18127]:0)
   [junit4]    >        at java.lang.Thread.getStackTrace(Thread.java:1589)
   [junit4]    >        at 
com.carrotsearch.randomizedtesting.RandomizedContext.closeAtEnd(RandomizedContext.java:166)
   [junit4]    >        at 
org.apache.lucene.util.LuceneTestCase.closeAfterSuite(LuceneTestCase.java:726)
   [junit4]    >        at 
org.apache.lucene.util.LuceneTestCase.wrapDirectory(LuceneTestCase.java:1312)
   [junit4]    >        at 
org.apache.lucene.util.LuceneTestCase.newDirectory(LuceneTestCase.java:1203)
   [junit4]    >        at 
org.apache.lucene.util.LuceneTestCase.newDirectory(LuceneTestCase.java:1195)
   [junit4]    >        at 
org.apache.solr.core.MockDirectoryFactory.create(MockDirectoryFactory.java:47)
   [junit4]    >        at 
org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:350)
   [junit4]    >        at 
org.apache.solr.core.SolrCore.getNewIndexDir(SolrCore.java:276)
   [junit4]    >        at 
org.apache.solr.core.SolrCore.initIndex(SolrCore.java:488)
   [junit4]    >        at 
org.apache.solr.core.SolrCore.<init>(SolrCore.java:794)
   [junit4]    >        at 
org.apache.solr.core.SolrCore.<init>(SolrCore.java:652)
   [junit4]    >        at 
org.apache.solr.core.CoreContainer.create(CoreContainer.java:509)
   [junit4]    >        at 
org.apache.solr.core.CoreContainer$1.call(CoreContainer.java:273)
   [junit4]    >        at 
org.apache.solr.core.CoreContainer$1.call(CoreContainer.java:267)
   [junit4]    >        at 
java.util.concurrent.FutureTask.run(FutureTask.java:262)
   [junit4]    >        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
   [junit4]    >        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]    > Caused by: java.lang.AssertionError: Directory not closed: 
MockDirectoryWrapper(SimpleFSDirectory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/index-SimpleFSDirectory-104
 
lockFactory=NativeFSLockFactory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler-E5E1422D69D18127-001/index-SimpleFSDirectory-104)
   [junit4]    >        at 
org.apache.lucene.util.CloseableDirectory.close(CloseableDirectory.java:47)
   [junit4]    >        at 
com.carrotsearch.randomizedtesting.RandomizedContext.closeResources(RandomizedContext.java:183)
   [junit4]    >        ... 1 more
   [junit4] Completed on J2 in 1053.38s, 14 tests, 1 error <<< FAILURES!

[...truncated 962 lines...]
BUILD FAILED
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:531:
 The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:472:
 The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:61:
 The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/extra-targets.xml:39:
 The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build.xml:189:
 The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/common-build.xml:496:
 The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/lucene/common-build.xml:1360:
 The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/lucene/common-build.xml:962:
 There were test failures: 437 suites, 1785 tests, 1 suite-level error, 53 
ignored (9 assumptions)

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


---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to