You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2013/07/26 10:03:14 UTC
[JENKINS] Lucene-Solr-trunk-Linux (64bit/jdk1.8.0-ea-b99) - Build #
6736 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/6736/
Java: 64bit/jdk1.8.0-ea-b99 -XX:+UseCompressedOops -XX:+UseG1GC
1 tests failed.
REGRESSION: org.apache.solr.handler.TestReplicationHandler.doTestStressReplication
Error Message:
timed out waiting for collection1 startAt time to exceed: Fri Jul 26 19:25:47 NFT 2013
Stack Trace:
java.lang.AssertionError: timed out waiting for collection1 startAt time to exceed: Fri Jul 26 19:25:47 NFT 2013
at __randomizedtesting.SeedInfo.seed([8D29F5A936D42AF0:5682F56F33FC4343]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.apache.solr.handler.TestReplicationHandler.watchCoreStartAt(TestReplicationHandler.java:1507)
at org.apache.solr.handler.TestReplicationHandler.doTestStressReplication(TestReplicationHandler.java:811)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:491)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
at java.lang.Thread.run(Thread.java:724)
Build Log:
[...truncated 9891 lines...]
[junit4] Suite: org.apache.solr.handler.TestReplicationHandler
[junit4] 2> 633001 T2533 oas.SolrTestCaseJ4.setUp ###Starting doTestReplicateAfterCoreReload
[junit4] 2> 633004 T2533 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 633009 T2533 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:41547
[junit4] 2> 633010 T2533 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 633010 T2533 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 633010 T2533 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master
[junit4] 2> 633010 T2533 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/'
[junit4] 2> 633022 T2533 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/solr.xml
[junit4] 2> 633022 T2533 oasc.ConfigSolr.fromFile /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/solr.xml does not exist, using default configuration
[junit4] 2> 633029 T2533 oasc.CoreContainer.<init> New CoreContainer 1210743831
[junit4] 2> 633029 T2533 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/]
[junit4] 2> 633029 T2533 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 633030 T2533 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 633030 T2533 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 633030 T2533 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 633030 T2533 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 633030 T2533 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 633031 T2533 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 633031 T2533 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 633031 T2533 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 633031 T2533 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 633036 T2543 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1
[junit4] 2> 633037 T2543 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/'
[junit4] 2> 633049 T2543 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 633055 T2543 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 633055 T2543 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 633057 T2543 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 633060 T2543 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 633060 T2543 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 633061 T2543 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/data/
[junit4] 2> 633061 T2543 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 633061 T2543 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/data
[junit4] 2> 633061 T2543 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/data/index/
[junit4] 2> 633061 T2543 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 633062 T2543 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/data/index
[junit4] 2> 633063 T2543 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@4f0a2f1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@9cb1191),segFN=segments_1,generation=1}
[junit4] 2> 633063 T2543 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 633064 T2543 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 633064 T2543 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 633064 T2543 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 633064 T2543 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 633064 T2543 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 633064 T2543 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 633066 T2543 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 633067 T2543 oass.SolrIndexSearcher.<init> Opening Searcher@5e294b8c main
[junit4] 2> 633067 T2543 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 633067 T2543 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 633068 T2543 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 633068 T2543 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 633068 T2543 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 633068 T2544 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5e294b8c main{StandardDirectoryReader(segments_1:1)}
[junit4] 2> 633068 T2533 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1
[junit4] 2> 633069 T2533 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 633069 T2533 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> 633076 T2533 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 633080 T2533 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:55002
[junit4] 2> 633080 T2533 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 633081 T2533 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 633081 T2533 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave
[junit4] 2> 633082 T2533 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/'
[junit4] 2> 633096 T2533 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/solr.xml
[junit4] 2> 633097 T2533 oasc.ConfigSolr.fromFile /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/solr.xml does not exist, using default configuration
[junit4] 2> 633105 T2533 oasc.CoreContainer.<init> New CoreContainer 1472346509
[junit4] 2> 633106 T2533 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/]
[junit4] 2> 633106 T2533 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 633106 T2533 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 633107 T2533 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 633107 T2533 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 633107 T2533 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 633108 T2533 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 633108 T2533 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 633108 T2533 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 633109 T2533 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 633109 T2533 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 633115 T2555 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1
[junit4] 2> 633115 T2555 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/'
[junit4] 2> 633127 T2555 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 633133 T2555 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 633133 T2555 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 633135 T2555 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 633137 T2555 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 633138 T2555 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 633138 T2555 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/data/
[junit4] 2> 633138 T2555 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 633139 T2555 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/data
[junit4] 2> 633139 T2555 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/data/index/
[junit4] 2> 633139 T2555 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 633139 T2555 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/data/index
[junit4] 2> 633140 T2555 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@6cb7a2d1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@36a151e6),segFN=segments_1,generation=1}
[junit4] 2> 633140 T2555 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 633141 T2555 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 633141 T2555 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 633141 T2555 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 633142 T2555 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 633142 T2555 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 633142 T2555 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 633143 T2555 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 633144 T2555 oass.SolrIndexSearcher.<init> Opening Searcher@72523f38 main
[junit4] 2> 633144 T2555 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 633144 T2555 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 633145 T2555 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
[junit4] 2> 633146 T2556 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@72523f38 main{StandardDirectoryReader(segments_1:1)}
[junit4] 2> 633146 T2555 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 633146 T2533 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1
[junit4] 2> 633147 T2533 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 633147 T2533 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> 633171 T2533 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1472346509
[junit4] 2> 633172 T2533 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@21d8e068
[junit4] 2> 633173 T2533 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> 633174 T2533 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 633174 T2533 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 633174 T2533 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 633175 T2533 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 633175 T2533 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 633176 T2533 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/data/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/data/index;done=false>>]
[junit4] 2> 633176 T2533 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/data/index
[junit4] 2> 633177 T2533 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/data [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/data;done=false>>]
[junit4] 2> 633177 T2533 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/data
[junit4] 2> 633177 T2533 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 633252 T2533 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1210743831
[junit4] 2> 633253 T2533 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@c0393ce
[junit4] 2> 633253 T2533 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> 633253 T2533 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 633254 T2533 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 633254 T2533 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 633255 T2533 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 633255 T2533 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 633256 T2533 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/data [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/data;done=false>>]
[junit4] 2> 633256 T2533 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/data
[junit4] 2> 633257 T2533 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/data/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/data/index;done=false>>]
[junit4] 2> 633257 T2533 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/data/index
[junit4] 2> 633258 T2533 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 633310 T2533 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 633313 T2533 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:41903
[junit4] 2> 633314 T2533 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 633314 T2533 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 633314 T2533 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master
[junit4] 2> 633315 T2533 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/'
[junit4] 2> 633330 T2533 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/solr.xml
[junit4] 2> 633330 T2533 oasc.ConfigSolr.fromFile /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/solr.xml does not exist, using default configuration
[junit4] 2> 633366 T2533 oasc.CoreContainer.<init> New CoreContainer 1051123126
[junit4] 2> 633366 T2533 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/]
[junit4] 2> 633367 T2533 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 633367 T2533 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 633367 T2533 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 633368 T2533 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 633368 T2533 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 633369 T2533 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 633369 T2533 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 633369 T2533 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 633370 T2533 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 633370 T2533 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 633376 T2568 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1
[junit4] 2> 633376 T2568 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/'
[junit4] 2> 633389 T2568 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 633395 T2568 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 633395 T2568 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 633398 T2568 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 633400 T2568 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 633400 T2568 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 633400 T2568 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/data/
[junit4] 2> 633400 T2568 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 633401 T2568 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/data
[junit4] 2> 633401 T2568 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/data/index/
[junit4] 2> 633401 T2568 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 633401 T2568 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/data/index
[junit4] 2> 633402 T2568 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@3195adaa lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2dfda166),segFN=segments_1,generation=1}
[junit4] 2> 633402 T2568 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 633403 T2568 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 633404 T2568 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 633404 T2568 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 633404 T2568 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 633404 T2568 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 633404 T2568 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 633405 T2568 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 633406 T2568 oass.SolrIndexSearcher.<init> Opening Searcher@666beb95 main
[junit4] 2> 633406 T2568 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 633406 T2568 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 633406 T2568 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml
[junit4] 2> 633407 T2568 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@3195adaa lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2dfda166),segFN=segments_1,generation=1}
[junit4] 2> 633407 T2568 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 633407 T2568 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 633408 T2568 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 633408 T2569 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@666beb95 main{StandardDirectoryReader(segments_1:1)}
[junit4] 2> 633408 T2533 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1
[junit4] 2> 633408 T2533 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 633409 T2533 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> ASYNC NEW_CORE C2393 name=collection1 org.apache.solr.core.SolrCore@6941c0a5
[junit4] 2> 633414 T2564 C2393 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 633415 T2564 C2393 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 1
[junit4] 2> 633417 T2565 C2393 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 633418 T2565 C2393 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@3195adaa lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2dfda166),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@3195adaa lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2dfda166),segFN=segments_2,generation=2}
[junit4] 2> 633418 T2565 C2393 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 633419 T2565 C2393 oass.SolrIndexSearcher.<init> Opening Searcher@12a498ab main
[junit4] 2> 633419 T2565 C2393 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 633419 T2569 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@12a498ab main{StandardDirectoryReader(segments_2:2:nrt)}
[junit4] 2> 633419 T2565 C2393 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 2
[junit4] 2> 633423 T2566 C2393 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={sort=id+desc&q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=2
[junit4] 2> 633424 T2533 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 633427 T2533 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:39960
[junit4] 2> 633427 T2533 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 633428 T2533 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 633428 T2533 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave
[junit4] 2> 633428 T2533 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/'
[junit4] 2> 633443 T2533 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/solr.xml
[junit4] 2> 633444 T2533 oasc.ConfigSolr.fromFile /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/solr.xml does not exist, using default configuration
[junit4] 2> 633450 T2533 oasc.CoreContainer.<init> New CoreContainer 2125010126
[junit4] 2> 633451 T2533 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/]
[junit4] 2> 633451 T2533 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 633452 T2533 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 633452 T2533 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 633452 T2533 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 633452 T2533 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 633452 T2533 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 633453 T2533 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 633453 T2533 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 633453 T2533 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 633453 T2533 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 633458 T2580 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1
[junit4] 2> 633458 T2580 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/'
[junit4] 2> 633470 T2580 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 633476 T2580 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 633476 T2580 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 633479 T2580 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 633482 T2580 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 633482 T2580 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 633482 T2580 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/data/
[junit4] 2> 633482 T2580 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 633483 T2580 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/data
[junit4] 2> 633483 T2580 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/data/index/
[junit4] 2> 633483 T2580 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 633483 T2580 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/data/index
[junit4] 2> 633484 T2580 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@50ca6c2f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@21f1a002),segFN=segments_1,generation=1}
[junit4] 2> 633484 T2580 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 633485 T2580 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 633485 T2580 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 633486 T2580 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 633486 T2580 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 633486 T2580 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 633486 T2580 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 633487 T2580 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 633488 T2580 oass.SolrIndexSearcher.<init> Opening Searcher@47a8515 main
[junit4] 2> 633488 T2580 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 633488 T2580 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 633489 T2580 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
[junit4] 2> 633489 T2581 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@47a8515 main{StandardDirectoryReader(segments_1:1)}
[junit4] 2> 633489 T2580 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 633489 T2533 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1
[junit4] 2> 633490 T2533 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 633490 T2533 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> ASYNC NEW_CORE C2394 name=collection1 org.apache.solr.core.SolrCore@6476efb3
[junit4] 2> 633496 T2576 C2394 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={sort=id+desc&q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=1
[junit4] 2> 633498 T2567 C2393 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=indexversion&_trace=getIndexVersion&wt=javabin&qt=/replication&version=2} status=0 QTime=0
[junit4] 2> 633500 T2564 C2393 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=commits&_trace=getCommits&wt=javabin&qt=/replication&version=2} status=0 QTime=0
[junit4] 2> 633502 T2565 oasc.CoreContainer.reload Reloading SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1
[junit4] 2> 633502 T2565 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/'
[junit4] 2> 633515 T2565 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 633521 T2565 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 633522 T2565 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 633524 T2565 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 633527 T2565 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 633527 T2565 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/data/
[junit4] 2> 633528 T2565 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 633528 T2565 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/data/index/
[junit4] 2> 633529 T2565 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 633529 T2565 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 633529 T2565 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 633530 T2565 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 633530 T2565 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 633530 T2565 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 633531 T2565 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 633532 T2565 oass.SolrIndexSearcher.<init> Opening Searcher@c3fe517 main
[junit4] 2> 633533 T2565 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 633533 T2565 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 633533 T2565 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml
[junit4] 2> 633533 T2565 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 633534 T2565 oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
[junit4] 2> 633534 T2584 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@c3fe517 main{StandardDirectoryReader(segments_2:2:nrt)}
[junit4] 2> 633534 T2565 oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused... core=collection1
[junit4] 2> 633534 T2565 oasu.DefaultSolrCoreState.newIndexWriter Closing old IndexWriter... core=collection1
[junit4] 2> 633535 T2565 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@3195adaa lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2dfda166),segFN=segments_2,generation=2}
[junit4] 2> 633535 T2565 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 633535 T2565 oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
[junit4] 2> 633536 T2565 oass.SolrIndexSearcher.<init> Opening Searcher@19005a3d main
[junit4] 2> 633536 T2565 oasc.CoreContainer.registerCore replacing core: collection1
[junit4] 2> 633536 T2565 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@6941c0a5
[junit4] 2> 633536 T2565 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
[junit4] 2> 633536 T2584 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@19005a3d main{StandardDirectoryReader(segments_2:2:nrt)}
[junit4] 2> 633537 T2565 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 633537 T2565 oass.SolrDispatchFilter.handleAdminRequest [admin] webapp=null path=/admin/cores params={action=reload&core=collection1&wt=javabin&qt=/admin/cores&version=2} status=0 QTime=35
[junit4] 2> ASYNC NEW_CORE C2395 name=collection1 org.apache.solr.core.SolrCore@410039ed
[junit4] 2> 633540 T2566 C2395 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=indexversion&_trace=getIndexVersion&wt=javabin&qt=/replication&version=2} status=0 QTime=1
[junit4] 2> 633541 T2567 C2395 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=commits&_trace=getCommits&wt=javabin&qt=/replication&version=2} status=0 QTime=0
[junit4] 2> 633544 T2564 C2395 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[10]} 0 1
[junit4] 2> 633545 T2565 C2395 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[20]} 0 0
[junit4] 2> 633547 T2566 C2395 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 633548 T2566 C2395 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@3195adaa lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2dfda166),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@3195adaa lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2dfda166),segFN=segments_3,generation=3}
[junit4] 2> 633549 T2566 C2395 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 633549 T2566 C2395 oass.SolrIndexSearcher.<init> Opening Searcher@5dd86e61 main
[junit4] 2> 633550 T2566 C2395 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 633550 T2584 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5dd86e61 main{StandardDirectoryReader(segments_3:4:nrt _0(5.0):C2)}
[junit4] 2> 633550 T2566 C2395 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 3
[junit4] 2> 633552 T2567 C2395 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={sort=id+desc&q=*:*&wt=javabin&version=2} hits=2 status=0 QTime=0
[junit4] 2> 633554 T2577 C2394 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={sort=id+desc&q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 633555 T2533 oash.TestReplicationHandler.rQuery Waiting for 2 docs
[junit4] 2> 633657 T2578 C2394 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={sort=id+desc&q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=1
[junit4] 2> 633657 T2533 oash.TestReplicationHandler.rQuery Waiting for 2 docs
[junit4] 2> 633759 T2579 C2394 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={sort=id+desc&q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 633760 T2533 oash.TestReplicationHandler.rQuery Waiting for 2 docs
[junit4] 2> 633862 T2576 C2394 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={sort=id+desc&q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 633863 T2533 oash.TestReplicationHandler.rQuery Waiting for 2 docs
[junit4] 2> 633965 T2578 C2394 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={sort=id+desc&q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=1
[junit4] 2> 633965 T2533 oash.TestReplicationHandler.rQuery Waiting for 2 docs
[junit4] 2> 634067 T2579 C2394 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={sort=id+desc&q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 634068 T2533 oash.TestReplicationHandler.rQuery Waiting for 2 docs
[junit4] 2> 634170 T2577 C2394 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={sort=id+desc&q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 634170 T2533 oash.TestReplicationHandler.rQuery Waiting for 2 docs
[junit4] 2> 634256 T2567 C2395 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=indexversion&qt=/replication&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 634256 T2582 oash.SnapPuller.fetchLatestIndex Master's generation: 3
[junit4] 2> 634256 T2582 oash.SnapPuller.fetchLatestIndex Slave's generation: 1
[junit4] 2> 634257 T2582 oash.SnapPuller.fetchLatestIndex Starting replication process
[junit4] 2> 634260 T2564 C2395 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=filelist&qt=/replication&wt=javabin&generation=3&version=2} status=0 QTime=2
[junit4] 2> 634260 T2582 oash.SnapPuller.fetchLatestIndex Number of files in latest index in master: 8
[junit4] 2> 634262 T2582 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/data/index.20130726192544007
[junit4] 2> 634262 T2582 oash.SnapPuller.fetchLatestIndex Starting download to MockDirWrapper(org.apache.lucene.store.RAMDirectory@543a8626 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@20e3c4e4) fullCopy=false
[junit4] 2> 634264 T2565 C2395 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.fnm&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=3} status=0 QTime=0
[junit4] 2> ASYNC NEW_CORE C2396 name=collection1 org.apache.solr.core.SolrCore@6476efb3
[junit4] 2> 634274 T2578 C2396 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={sort=id+desc&q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 634275 T2533 oash.TestReplicationHandler.rQuery Waiting for 2 docs
[junit4] 2> ASYNC NEW_CORE C2397 name=collection1 org.apache.solr.core.SolrCore@410039ed
[junit4] 2> 634275 T2566 C2397 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.nvd&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=3} status=0 QTime=0
[junit4] 2> 634277 T2567 C2397 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0_SimpleText_0.pst&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=3} status=0 QTime=0
[junit4] 2> 634280 T2564 C2397 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.fdx&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=3} status=0 QTime=0
[junit4] 2> 634282 T2565 C2397 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.nvm&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=3} status=0 QTime=0
[junit4] 2> 634284 T2566 C2397 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.si&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=3} status=0 QTime=0
[junit4] 2> 634287 T2567 C2397 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=segments_3&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=3} status=0 QTime=0
[junit4] 2> 634289 T2564 C2397 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.fdt&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=3} status=0 QTime=0
[junit4] 2> 634290 T2582 oash.SnapPuller.fetchLatestIndex Total time taken for download : 0 secs
[junit4] 2> 634291 T2582 oasu.DefaultSolrCoreState.closeIndexWriter Closing IndexWriter...
[junit4] 2> 634291 T2582 oasu.DefaultSolrCoreState.closeIndexWriter Waiting until IndexWriter is unused... core=collection1
[junit4] 2> 634292 T2582 oasu.DefaultSolrCoreState.openIndexWriter Creating new IndexWriter...
[junit4] 2> 634293 T2582 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=2
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@50ca6c2f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@21f1a002),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@50ca6c2f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@21f1a002),segFN=segments_3,generation=3}
[junit4] 2> 634294 T2582 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 634294 T2582 oasu.DefaultSolrCoreState.openIndexWriter New IndexWriter is ready to be used.
[junit4] 2> 634295 T2582 oass.SolrIndexSearcher.<init> Opening Searcher@e34ce4f main
[junit4] 2> 634295 T2581 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@e34ce4f main{StandardDirectoryReader(segments_3:4:nrt _0(5.0):C2)}
[junit4] 2> 634295 T2582 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/data/index.20130726192544007 [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/data/index.20130726192544007;done=true>>]
[junit4] 2> 634296 T2582 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/data/index.20130726192544007
[junit4] 2> 634377 T2577 C2396 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={sort=id+desc&q=*:*&wt=javabin&version=2} hits=2 status=0 QTime=0
[junit4] 2> 634378 T2533 oas.SolrTestCaseJ4.tearDown ###Ending doTestReplicateAfterCoreReload
[junit4] 2> 634399 T2533 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1051123126
[junit4] 2> 634400 T2533 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@410039ed
[junit4] 2> 634400 T2533 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=2,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 634401 T2533 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 634401 T2533 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 634401 T2533 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 634402 T2533 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 634402 T2533 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 634402 T2533 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/data/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/data/index;done=false>>]
[junit4] 2> 634403 T2533 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/data/index
[junit4] 2> 634403 T2533 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/data [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/data;done=false>>]
[junit4] 2> 634403 T2533 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342748/master/collection1/data
[junit4] 2> 634404 T2533 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 634482 T2533 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=2125010126
[junit4] 2> 634483 T2533 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@6476efb3
[junit4] 2> 634483 T2533 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> 634484 T2533 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 634484 T2533 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 634485 T2533 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 634486 T2533 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 634486 T2533 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 634487 T2533 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/data/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/data/index;done=false>>]
[junit4] 2> 634487 T2533 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/data/index
[junit4] 2> 634487 T2533 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/data [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/data;done=false>>]
[junit4] 2> 634488 T2533 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825342819/slave/collection1/data
[junit4] 2> 634488 T2533 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 634548 T2533 oas.SolrTestCaseJ4.setUp ###Starting doTestStressReplication
[junit4] 2> 634551 T2533 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 634553 T2533 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:36254
[junit4] 2> 634554 T2533 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 634554 T2533 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 634554 T2533 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344294/master
[junit4] 2> 634554 T2533 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344294/master/'
[junit4] 2> 634568 T2533 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344294/master/solr.xml
[junit4] 2> 634568 T2533 oasc.ConfigSolr.fromFile /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344294/master/solr.xml does not exist, using default configuration
[junit4] 2> 634577 T2533 oasc.CoreContainer.<init> New CoreContainer 25668646
[junit4] 2> 634577 T2533 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344294/master/]
[junit4] 2> 634578 T2533 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 634578 T2533 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 634578 T2533 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 634579 T2533 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 634579 T2533 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 634580 T2533 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 634580 T2533 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 634580 T2533 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 634581 T2533 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 634581 T2533 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 634588 T2595 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344294/master/collection1
[junit4] 2> 634588 T2595 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344294/master/collection1/'
[junit4] 2> 634601 T2595 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 634607 T2595 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 634608 T2595 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 634610 T2595 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 634612 T2595 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 634613 T2595 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 634613 T2595 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344294/master/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344294/master/collection1/data/
[junit4] 2> 634613 T2595 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 634614 T2595 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344294/master/collection1/data
[junit4] 2> 634614 T2595 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344294/master/collection1/data/index/
[junit4] 2> 634614 T2595 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344294/master/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 634614 T2595 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344294/master/collection1/data/index
[junit4] 2> 634615 T2595 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@f18e280 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@516e7fb),segFN=segments_1,generation=1}
[junit4] 2> 634615 T2595 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 634616 T2595 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 634616 T2595 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 634617 T2595 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 634617 T2595 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 634617 T2595 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 634617 T2595 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 634619 T2595 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 634619 T2595 oass.SolrIndexSearcher.<init> Opening Searcher@211132e7 main
[junit4] 2> 634620 T2595 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 634620 T2595 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 634620 T2595 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 634620 T2595 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 634620 T2596 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@211132e7 main{StandardDirectoryReader(segments_1:1)}
[junit4] 2> 634621 T2595 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 634621 T2533 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1
[junit4] 2> 634621 T2533 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 634622 T2533 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> 634626 T2533 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 634628 T2533 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:45683
[junit4] 2> 634628 T2533 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 634629 T2533 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 634629 T2533 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave
[junit4] 2> 634629 T2533 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/'
[junit4] 2> 634639 T2533 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/solr.xml
[junit4] 2> 634639 T2533 oasc.ConfigSolr.fromFile /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/solr.xml does not exist, using default configuration
[junit4] 2> 634645 T2533 oasc.CoreContainer.<init> New CoreContainer 1013541559
[junit4] 2> 634646 T2533 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/]
[junit4] 2> 634646 T2533 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 634646 T2533 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 634647 T2533 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 634647 T2533 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 634647 T2533 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 634647 T2533 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 634648 T2533 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 634648 T2533 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 634648 T2533 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 634648 T2533 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 634652 T2607 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/collection1
[junit4] 2> 634652 T2607 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/collection1/'
[junit4] 2> 634666 T2607 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 634672 T2607 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 634672 T2607 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 634675 T2607 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 634677 T2607 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 634678 T2607 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 634678 T2607 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/collection1/data/
[junit4] 2> 634678 T2607 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 634679 T2607 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/collection1/data
[junit4] 2> 634679 T2607 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/collection1/data/index/
[junit4] 2> 634679 T2607 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 634680 T2607 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/collection1/data/index
[junit4] 2> 634681 T2607 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@46ed8787 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d5e1dfb),segFN=segments_1,generation=1}
[junit4] 2> 634681 T2607 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 634682 T2607 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 634683 T2607 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 634683 T2607 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 634683 T2607 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 634683 T2607 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 634683 T2607 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 634684 T2607 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 634685 T2607 oass.SolrIndexSearcher.<init> Opening Searcher@2927b932 main
[junit4] 2> 634685 T2607 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 634685 T2607 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 634686 T2607 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
[junit4] 2> 634686 T2608 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2927b932 main{StandardDirectoryReader(segments_1:1)}
[junit4] 2> 634686 T2607 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 634687 T2533 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1
[junit4] 2> 634687 T2533 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 634687 T2533 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> 634712 T2533 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1013541559
[junit4] 2> 634713 T2533 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@c1e84f9
[junit4] 2> 634713 T2533 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> 634713 T2533 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 634713 T2533 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 634714 T2533 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 634714 T2533 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 634714 T2533 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 634715 T2533 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/collection1/data/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/collection1/data/index;done=false>>]
[junit4] 2> 634715 T2533 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/collection1/data/index
[junit4] 2> 634715 T2533 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/collection1/data [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/collection1/data;done=false>>]
[junit4] 2> 634715 T2533 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/collection1/data
[junit4] 2> 634716 T2533 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 634767 T2533 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 634770 T2533 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:59633
[junit4] 2> 634770 T2533 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 634771 T2533 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 634771 T2533 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave
[junit4] 2> 634771 T2533 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/'
[junit4] 2> 634780 T2533 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/solr.xml
[junit4] 2> 634781 T2533 oasc.ConfigSolr.fromFile /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/solr.xml does not exist, using default configuration
[junit4] 2> 634787 T2533 oasc.CoreContainer.<init> New CoreContainer 1058530462
[junit4] 2> 634787 T2533 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/]
[junit4] 2> 634787 T2533 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 634788 T2533 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 634788 T2533 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 634788 T2533 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 634788 T2533 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 634788 T2533 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 634789 T2533 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 634789 T2533 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 634789 T2533 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 634790 T2533 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 634794 T2620 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/collection1
[junit4] 2> 634794 T2620 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/collection1/'
[junit4] 2> 634807 T2620 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 634814 T2620 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 634814 T2620 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 634817 T2620 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 634819 T2620 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 634820 T2620 oasc.SolrCore.initDirectoryFactory solr.StandardDirectoryFactory
[junit4] 2> 634820 T2620 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/collection1/data/
[junit4] 2> 634820 T2620 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 634820 T2620 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/collection1/data
[junit4] 2> 634820 T2620 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/collection1/data/index/
[junit4] 2> 634821 T2620 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 634821 T2620 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/collection1/data/index
[junit4] 2> 634829 T2620 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825344370/slave/collection1/data/index,segFN=segments_1,generation=1}
[junit4] 2> 634829 T2620 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 634830 T2620 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 634830 T2620 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 634830 T2620 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 634830 T2620 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 634830 T2620 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 634830 T2620 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 634831 T2620 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 634833 T2620 oass.SolrIndexSearcher.<init> Opening Searcher@15d3d298 main
[junit4] 2> 634833 T2620 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 634833 T2620 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 634833 T2620 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 634833 T2620 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 634833 T2621 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@15d3d298 main{StandardDirectoryReader(segments_1:1)}
[junit4] 2> 634834 T2533 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1
[junit4] 2> 634834 T2533 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 634835 T2533 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> 634874 T2533 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=25668646
[junit4] 2> 634875 T2533 oasc.SolrCore.close [collection1
[...truncated too long message...]
ommand=backup} status=0 QTime=0
[junit4] 2> 697065 T3215 C2477 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 697064 T3225 oash.SnapShooter.createSnapshot Creating backup snapshot...
[junit4] 2> 697255 T3206 oash.SnapPuller.fetchLatestIndex ERROR Master at: http://127.0.0.1:35659/solr is not available. Index fetch failed. Exception: org.apache.solr.client.solrj.SolrServerException: Server refused connection at: http://127.0.0.1:35659/solr
[junit4] 2> 697267 T3213 C2477 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 697271 T2533 oas.SolrTestCaseJ4.tearDown ###Ending doTestBackup
[junit4] 2> 697297 T2533 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=949615848
[junit4] 2> 697298 T2533 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@7f9d2368
[junit4] 2> 697298 T2533 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=492,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
[junit4] 2> 697298 T2533 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 697299 T2533 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 697299 T2533 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 697300 T2533 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 697300 T2533 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 697301 T2533 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825404329/master/collection1/data/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825404329/master/collection1/data/index;done=false>>]
[junit4] 2> 697301 T2533 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825404329/master/collection1/data/index
[junit4] 2> 697301 T2533 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825404329/master/collection1/data [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825404329/master/collection1/data;done=false>>]
[junit4] 2> 697301 T2533 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825404329/master/collection1/data
[junit4] 2> 697302 T2533 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 697374 T2533 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=37973603
[junit4] 2> 697374 T2533 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@32d54cfd
[junit4] 2> 697375 T2533 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> 697375 T2533 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 697375 T2533 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 697376 T2533 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 697376 T2533 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 697376 T2533 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 697377 T2533 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825404418/slave/collection1/data [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825404418/slave/collection1/data;done=false>>]
[junit4] 2> 697377 T2533 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825404418/slave/collection1/data
[junit4] 2> 697377 T2533 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825404418/slave/collection1/data/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825404418/slave/collection1/data/index;done=false>>]
[junit4] 2> 697377 T2533 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.handler.TestReplicationHandler$SolrInstance-1374825404418/slave/collection1/data/index
[junit4] 2> 697378 T2533 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 697432 T2533 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: test params are: codec=Lucene42: {newname=PostingsFormat(name=SimpleText), id=PostingsFormat(name=SimpleText), name=PostingsFormat(name=SimpleText)}, docValues:{}, sim=DefaultSimilarity, locale=pt_PT, timezone=Pacific/Norfolk
[junit4] 2> NOTE: Linux 3.2.0-49-generic amd64/Oracle Corporation 1.8.0-ea (64-bit)/cpus=8,threads=1,free=232842192,total=379584512
[junit4] 2> NOTE: All tests run in this JVM: [TestHashPartitioner, TestSuggestSpellingConverter, DefaultValueUpdateProcessorTest, TestPartialUpdateDeduplication, HdfsUnloadDistributedZkTest, TestDistributedGrouping, TestMultiCoreConfBootstrap, TestLMJelinekMercerSimilarityFactory, CurrencyFieldXmlFileTest, IndexReaderFactoryTest, TestComponentsName, NoCacheHeaderTest, BasicDistributedZk2Test, BasicZkTest, CoreContainerCoreInitFailuresTest, HdfsCollectionsAPIDistributedZkTest, OutputWriterTest, HdfsChaosMonkeySafeLeaderTest, TestBinaryResponseWriter, CollectionsAPIDistributedZkTest, SolrCmdDistributorTest, TestZkChroot, NotRequiredUniqueKeyTest, TestAnalyzedSuggestions, SpellCheckComponentTest, DeleteShardTest, TestSystemIdResolver, TermVectorComponentDistributedTest, ShardRoutingCustomTest, XmlUpdateRequestHandlerTest, DirectSolrSpellCheckerTest, BlockCacheTest, TestArbitraryIndexDir, TestFoldingMultitermQuery, TestJmxMonitoredMap, SolrRequestParserTest, TestCodecSupport, TestRecovery, ZkNodePropsTest, TestCollationField, TestQueryTypes, SampleTest, RequestHandlersTest, SuggesterTSTTest, TestRangeQuery, SolrIndexConfigTest, TestDistributedSearch, TestNumberUtils, DistanceFunctionTest, SolrPluginUtilsTest, TestRecoveryHdfs, FullSolrCloudDistribCmdsTest, QueryResultKeyTest, DirectUpdateHandlerTest, SortByFunctionTest, TestCloudManagedSchemaAddField, TestBM25SimilarityFactory, IndexBasedSpellCheckerTest, TestIndexSearcher, HdfsLockFactoryTest, TestUtils, TestMergePolicyConfig, StatsComponentTest, DOMUtilTest, SpellCheckCollatorTest, DocValuesMultiTest, DebugComponentTest, TestJmxIntegration, TestDFRSimilarityFactory, HardAutoCommitTest, TestStressReorder, TestFastOutputStream, HdfsSyncSliceTest, PingRequestHandlerTest, TestUpdate, ChaosMonkeySafeLeaderTest, UnloadDistributedZkTest, SyncSliceTest, OpenCloseCoreStressTest, LeaderElectionIntegrationTest, TestReplicationHandler]
[junit4] Completed on J1 in 64.46s, 14 tests, 1 failure <<< FAILURES!
[...truncated 471 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:389: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:369: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:39: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:181: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:449: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1230: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:873: There were test failures: 318 suites, 1342 tests, 1 failure, 37 ignored (6 assumptions)
Total time: 37 minutes 25 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/jdk1.8.0-ea-b99 -XX:+UseCompressedOops -XX:+UseG1GC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure