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/08/21 08:08:46 UTC
[JENKINS] Lucene-Solr-4.x-Windows (64bit/jdk1.8.0-ea-b102) - Build
# 3101 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Windows/3101/
Java: 64bit/jdk1.8.0-ea-b102 -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: Wed Aug 21 03:56:16 FNT 2013
Stack Trace:
java.lang.AssertionError: timed out waiting for collection1 startAt time to exceed: Wed Aug 21 03:56:16 FNT 2013
at __randomizedtesting.SeedInfo.seed([10800B1810AD4B15:CB2B0BDE158522A6]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.apache.solr.handler.TestReplicationHandler.watchCoreStartAt(TestReplicationHandler.java:1513)
at org.apache.solr.handler.TestReplicationHandler.doTestStressReplication(TestReplicationHandler.java:817)
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 10225 lines...]
[junit4] Suite: org.apache.solr.handler.TestReplicationHandler
[junit4] 2> 1464038 T4527 oas.SolrTestCaseJ4.setUp ###Starting doTestRepeater
[junit4] 2> 1464049 T4527 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 1464053 T4527 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:50408
[junit4] 2> 1464053 T4527 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 1464053 T4527 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1464054 T4527 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562884\master
[junit4] 2> 1464054 T4527 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562884\master\'
[junit4] 2> 1464076 T4527 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562884\master\solr.xml
[junit4] 2> 1464078 T4527 oasc.ConfigSolr.fromFile C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562884\master\solr.xml does not exist, using default configuration
[junit4] 2> 1464085 T4527 oasc.CoreContainer.<init> New CoreContainer 1908163574
[junit4] 2> 1464085 T4527 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562884\master\]
[junit4] 2> 1464086 T4527 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 1464086 T4527 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 1464086 T4527 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 1464086 T4527 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 1464086 T4527 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 1464086 T4527 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 1464086 T4527 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 1464087 T4527 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 1464087 T4527 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 1464087 T4527 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 1464099 T4537 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562884\master\collection1
[junit4] 2> 1464099 T4537 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562884\master\collection1\'
[junit4] 2> 1464117 T4537 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_45
[junit4] 2> 1464122 T4537 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1464122 T4537 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 1464124 T4537 oass.IndexSchema.readSchema [null] Schema name=test
[junit4] 2> 1464129 T4537 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1464129 T4537 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1464130 T4537 oasc.SolrCore.<init> [collection1] Opening new SolrCore at .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562884\master\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562884\master\collection1\data\
[junit4] 2> 1464130 T4537 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 1464130 T4537 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562884\master\collection1\data\
[junit4] 2> 1464130 T4537 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562884\master\collection1\data\index/
[junit4] 2> 1464130 T4537 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562884\master\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 1464130 T4537 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562884\master\collection1\data\index
[junit4] 2> 1464130 T4537 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=10, maxMergeAtOnceExplicit=25, maxMergedSegmentMB=81.4375, floorSegmentMB=1.0869140625, forceMergeDeletesPctAllowed=26.209818917572306, segmentsPerTier=17.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 1464133 T4537 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@3cdbf23f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1b5f385d),segFN=segments_1,generation=1}
[junit4] 2> 1464133 T4537 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1464134 T4537 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1464134 T4537 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 1464134 T4537 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 1464134 T4537 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 1464134 T4537 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 1464134 T4537 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 1464135 T4537 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 1464138 T4537 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1464139 T4537 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 1464139 T4537 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 1464139 T4537 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=44, maxMergeAtOnceExplicit=14, maxMergedSegmentMB=76.4287109375, floorSegmentMB=1.0263671875, forceMergeDeletesPctAllowed=1.8341537089865534, segmentsPerTier=47.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8895780416016595
[junit4] 2> 1464140 T4537 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@3cdbf23f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1b5f385d),segFN=segments_1,generation=1}
[junit4] 2> 1464140 T4537 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1464140 T4537 oass.SolrIndexSearcher.<init> Opening Searcher@2fb06934 main
[junit4] 2> 1464141 T4537 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 1464141 T4537 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 1464141 T4537 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 1464141 T4538 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2fb06934 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 1464141 T4527 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 1464141 T4527 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 1464141 T4527 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> 1464153 T4527 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 1464154 T4527 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:50411
[junit4] 2> 1464155 T4527 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 1464156 T4527 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1464156 T4527 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave
[junit4] 2> 1464156 T4527 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\'
[junit4] 2> 1464170 T4527 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\solr.xml
[junit4] 2> 1464170 T4527 oasc.ConfigSolr.fromFile C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\solr.xml does not exist, using default configuration
[junit4] 2> 1464175 T4527 oasc.CoreContainer.<init> New CoreContainer 49686880
[junit4] 2> 1464176 T4527 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\]
[junit4] 2> 1464176 T4527 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 1464176 T4527 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 1464177 T4527 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 1464177 T4527 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 1464177 T4527 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 1464177 T4527 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 1464177 T4527 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 1464177 T4527 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 1464177 T4527 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 1464178 T4527 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 1464182 T4549 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\collection1
[junit4] 2> 1464182 T4549 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\collection1\'
[junit4] 2> 1464200 T4549 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_45
[junit4] 2> 1464221 T4549 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1464221 T4549 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 1464223 T4549 oass.IndexSchema.readSchema [null] Schema name=test
[junit4] 2> 1464226 T4549 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1464226 T4549 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1464226 T4549 oasc.SolrCore.<init> [collection1] Opening new SolrCore at .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\collection1\data\
[junit4] 2> 1464226 T4549 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 1464226 T4549 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\collection1\data\
[junit4] 2> 1464226 T4549 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\collection1\data\index/
[junit4] 2> 1464226 T4549 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 1464227 T4549 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\collection1\data\index
[junit4] 2> 1464227 T4549 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=10, maxMergeAtOnceExplicit=25, maxMergedSegmentMB=81.4375, floorSegmentMB=1.0869140625, forceMergeDeletesPctAllowed=26.209818917572306, segmentsPerTier=17.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 1464228 T4549 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@4b2b7777 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1374d3a8),segFN=segments_1,generation=1}
[junit4] 2> 1464228 T4549 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1464228 T4549 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1464228 T4549 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 1464228 T4549 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 1464229 T4549 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 1464229 T4549 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 1464229 T4549 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 1464229 T4549 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 1464230 T4549 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1464231 T4549 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 1464231 T4549 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 1464231 T4549 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=44, maxMergeAtOnceExplicit=14, maxMergedSegmentMB=76.4287109375, floorSegmentMB=1.0263671875, forceMergeDeletesPctAllowed=1.8341537089865534, segmentsPerTier=47.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8895780416016595
[junit4] 2> 1464232 T4549 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@4b2b7777 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1374d3a8),segFN=segments_1,generation=1}
[junit4] 2> 1464232 T4549 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1464232 T4549 oass.SolrIndexSearcher.<init> Opening Searcher@afcb011 main
[junit4] 2> 1464236 T4549 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
[junit4] 2> 1464236 T4549 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 1464236 T4550 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@afcb011 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 1464236 T4527 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 1464237 T4527 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 1464237 T4527 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> 1464249 T4527 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=49686880
[junit4] 2> 1464250 T4527 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@319c285e
[junit4] 2> 1464251 T4527 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> 1464251 T4527 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 1464251 T4527 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 1464252 T4527 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 1464252 T4527 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 1464252 T4527 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 1464252 T4527 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\collection1\data\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\collection1\data\index;done=false>>]
[junit4] 2> 1464252 T4527 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\collection1\data\index
[junit4] 2> 1464253 T4527 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\collection1\data\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\collection1\data\;done=false>>]
[junit4] 2> 1464253 T4527 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\collection1\data\
[junit4] 2> 1464253 T4527 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 1464305 T4527 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 1464308 T4527 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:50414
[junit4] 2> 1464309 T4527 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 1464309 T4527 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1464309 T4527 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave
[junit4] 2> 1464309 T4527 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\'
[junit4] 2> 1464322 T4527 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\solr.xml
[junit4] 2> 1464322 T4527 oasc.ConfigSolr.fromFile C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\solr.xml does not exist, using default configuration
[junit4] 2> 1464328 T4527 oasc.CoreContainer.<init> New CoreContainer 1584166576
[junit4] 2> 1464329 T4527 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\]
[junit4] 2> 1464329 T4527 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 1464329 T4527 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 1464329 T4527 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 1464329 T4527 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 1464329 T4527 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 1464329 T4527 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 1464330 T4527 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 1464330 T4527 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 1464330 T4527 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 1464330 T4527 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 1464335 T4562 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\collection1
[junit4] 2> 1464335 T4562 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\collection1\'
[junit4] 2> 1464354 T4562 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_45
[junit4] 2> 1464359 T4562 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1464359 T4562 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 1464361 T4562 oass.IndexSchema.readSchema [null] Schema name=test
[junit4] 2> 1464363 T4562 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1464363 T4562 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1464364 T4562 oasc.SolrCore.<init> [collection1] Opening new SolrCore at .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\collection1\data\
[junit4] 2> 1464364 T4562 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 1464364 T4562 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\collection1\data\
[junit4] 2> 1464364 T4562 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\collection1\data\index/
[junit4] 2> 1464364 T4562 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 1464364 T4562 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\collection1\data\index
[junit4] 2> 1464364 T4562 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=10, maxMergeAtOnceExplicit=25, maxMergedSegmentMB=81.4375, floorSegmentMB=1.0869140625, forceMergeDeletesPctAllowed=26.209818917572306, segmentsPerTier=17.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 1464365 T4562 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@36bded46 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@19c03a89),segFN=segments_1,generation=1}
[junit4] 2> 1464365 T4562 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1464366 T4562 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1464366 T4562 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 1464366 T4562 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 1464366 T4562 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 1464366 T4562 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 1464366 T4562 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 1464367 T4562 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 1464368 T4562 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1464368 T4562 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 1464368 T4562 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 1464368 T4562 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=44, maxMergeAtOnceExplicit=14, maxMergedSegmentMB=76.4287109375, floorSegmentMB=1.0263671875, forceMergeDeletesPctAllowed=1.8341537089865534, segmentsPerTier=47.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8895780416016595
[junit4] 2> 1464369 T4562 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@36bded46 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@19c03a89),segFN=segments_1,generation=1}
[junit4] 2> 1464369 T4562 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1464369 T4562 oass.SolrIndexSearcher.<init> Opening Searcher@39cbe72f main
[junit4] 2> 1464369 T4562 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 1464369 T4562 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 1464369 T4563 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@39cbe72f main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 1464370 T4527 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 1464371 T4527 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 1464371 T4527 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> 1464382 T4527 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 1464384 T4527 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:50417
[junit4] 2> 1464384 T4527 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 1464384 T4527 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1464384 T4527 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064563219\repeater
[junit4] 2> 1464385 T4527 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064563219\repeater\'
[junit4] 2> 1464399 T4527 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064563219\repeater\solr.xml
[junit4] 2> 1464400 T4527 oasc.ConfigSolr.fromFile C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064563219\repeater\solr.xml does not exist, using default configuration
[junit4] 2> 1464405 T4527 oasc.CoreContainer.<init> New CoreContainer 970848300
[junit4] 2> 1464405 T4527 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064563219\repeater\]
[junit4] 2> 1464405 T4527 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 1464405 T4527 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 1464406 T4527 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 1464406 T4527 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 1464406 T4527 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 1464407 T4527 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 1464407 T4527 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 1464407 T4527 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 1464407 T4527 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 1464407 T4527 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 1464412 T4576 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064563219\repeater\collection1
[junit4] 2> 1464412 T4576 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064563219\repeater\collection1\'
[junit4] 2> 1464429 T4576 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_45
[junit4] 2> 1464433 T4576 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1464434 T4576 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 1464436 T4576 oass.IndexSchema.readSchema [null] Schema name=test
[junit4] 2> 1464438 T4576 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1464438 T4576 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1464438 T4576 oasc.SolrCore.<init> [collection1] Opening new SolrCore at .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064563219\repeater\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064563219\repeater\collection1\data\
[junit4] 2> 1464438 T4576 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 1464439 T4576 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064563219\repeater\collection1\data\
[junit4] 2> 1464439 T4576 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064563219\repeater\collection1\data\index/
[junit4] 2> 1464439 T4576 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064563219\repeater\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 1464439 T4576 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064563219\repeater\collection1\data\index
[junit4] 2> 1464439 T4576 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=10, maxMergeAtOnceExplicit=25, maxMergedSegmentMB=81.4375, floorSegmentMB=1.0869140625, forceMergeDeletesPctAllowed=26.209818917572306, segmentsPerTier=17.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 1464439 T4576 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@184fd43d lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@9aaf4d4),segFN=segments_1,generation=1}
[junit4] 2> 1464439 T4576 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1464441 T4576 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1464441 T4576 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 1464441 T4576 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 1464441 T4576 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 1464441 T4576 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 1464441 T4576 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 1464441 T4576 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 1464443 T4576 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1464443 T4576 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 1464444 T4576 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 1464444 T4576 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=44, maxMergeAtOnceExplicit=14, maxMergedSegmentMB=76.4287109375, floorSegmentMB=1.0263671875, forceMergeDeletesPctAllowed=1.8341537089865534, segmentsPerTier=47.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8895780416016595
[junit4] 2> 1464444 T4576 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@184fd43d lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@9aaf4d4),segFN=segments_1,generation=1}
[junit4] 2> 1464445 T4576 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1464445 T4576 oass.SolrIndexSearcher.<init> Opening Searcher@21ddca88 main
[junit4] 2> 1464445 T4576 oash.SnapPuller.<init> WARN 'masterUrl' must be specified without the /replication suffix
[junit4] 2> 1464445 T4576 oash.SnapPuller.<init> No value set for 'pollInterval'. Timer Task not started.
[junit4] 2> 1464445 T4576 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml
[junit4] 2> 1464445 T4576 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 1464445 T4576 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 1464445 T4577 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@21ddca88 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 1464446 T4527 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 1464446 T4527 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 1464446 T4527 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> ASYNC NEW_CORE C1603 name=collection1 org.apache.solr.core.SolrCore@5b49548c
[junit4] 2> 1464450 T4531 C1603 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0]} 0 0
[junit4] 2> 1464453 T4532 C1603 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1]} 0 0
[junit4] 2> 1464455 T4534 C1603 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2]} 0 0
[junit4] 2> 1464457 T4535 C1603 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1464457 T4535 C1603 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@3cdbf23f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1b5f385d),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@3cdbf23f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1b5f385d),segFN=segments_2,generation=2}
[junit4] 2> 1464458 T4535 C1603 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 1464458 T4535 C1603 oass.SolrIndexSearcher.<init> Opening Searcher@90363b4 main
[junit4] 2> 1464458 T4535 C1603 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 1464458 T4538 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@90363b4 main{StandardDirectoryReader(segments_2:3:nrt _0(4.5):C3)}
[junit4] 2> 1464458 T4535 C1603 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 1
[junit4] 2> 1464461 T4579 oash.SnapPuller.<init> WARN 'masterUrl' must be specified without the /replication suffix
[junit4] 2> 1464461 T4579 oash.SnapPuller.<init> No value set for 'pollInterval'. Timer Task not started.
[junit4] 2> 1464462 T4536 C1603 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=indexversion&qt=/replication&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1464463 T4579 oash.SnapPuller.fetchLatestIndex Master's generation: 2
[junit4] 2> 1464463 T4579 oash.SnapPuller.fetchLatestIndex Slave's generation: 1
[junit4] 2> 1464463 T4579 oash.SnapPuller.fetchLatestIndex Starting replication process
[junit4] 2> 1464472 T4531 C1603 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=filelist&qt=/replication&wt=javabin&generation=2&version=2} status=0 QTime=8
[junit4] 2> 1464472 T4579 oash.SnapPuller.fetchLatestIndex Number of files in latest index in master: 10
[junit4] 2> 1464482 T4579 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064563219\repeater\collection1\data\index.20130821035603327
[junit4] 2> 1464482 T4579 oash.SnapPuller.fetchLatestIndex Starting download to MockDirWrapper(org.apache.lucene.store.RAMDirectory@6c68913b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1889aea6) fullCopy=false
[junit4] 2> 1464483 T4533 C1603 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.fnm&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 1464485 T4532 C1603 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0_Lucene41_0.doc&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 1464487 T4534 C1603 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.nvd&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 1464489 T4535 C1603 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=segments_2&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 1464491 T4536 C1603 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.fdx&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 1464492 T4531 C1603 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.nvm&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 1464494 T4533 C1603 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.si&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 1464496 T4532 C1603 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0_Lucene41_0.tim&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 1464498 T4534 C1603 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0_Lucene41_0.tip&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> ASYNC NEW_CORE C1604 name=collection1 org.apache.solr.core.SolrCore@5b49548c
[junit4] 2> 1464518 T4535 C1604 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.fdt&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=1
[junit4] 2> 1464518 T4579 oash.SnapPuller.fetchLatestIndex Total time taken for download : 0 secs
[junit4] 2> 1464520 T4579 oasu.DefaultSolrCoreState.closeIndexWriter Closing IndexWriter...
[junit4] 2> 1464520 T4579 oasu.DefaultSolrCoreState.closeIndexWriter Waiting until IndexWriter is unused... core=collection1
[junit4] 2> 1464520 T4579 oasu.DefaultSolrCoreState.closeIndexWriter Rollback old IndexWriter... core=collection1
[junit4] 2> 1464520 T4579 oasu.DefaultSolrCoreState.openIndexWriter Creating new IndexWriter...
[junit4] 2> 1464520 T4579 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=11, maxMergeAtOnceExplicit=47, maxMergedSegmentMB=81.43359375, floorSegmentMB=0.3310546875, forceMergeDeletesPctAllowed=24.43153721398542, segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.45210632662671635
[junit4] 2> 1464520 T4579 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=2
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@184fd43d lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@9aaf4d4),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@184fd43d lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@9aaf4d4),segFN=segments_2,generation=2}
[junit4] 2> 1464520 T4579 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 1464521 T4579 oasu.DefaultSolrCoreState.openIndexWriter New IndexWriter is ready to be used.
[junit4] 2> 1464521 T4579 oass.SolrIndexSearcher.<init> Opening Searcher@129eabc9 main
[junit4] 2> 1464521 T4577 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@129eabc9 main{StandardDirectoryReader(segments_2:3:nrt _0(4.5):C3)}
[junit4] 2> 1464522 T4579 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064563219\repeater\collection1\data\index.20130821035603327 [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064563219\repeater\collection1\data\index.20130821035603327;done=true>>]
[junit4] 2> 1464522 T4579 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064563219\repeater\collection1\data\index.20130821035603327
[junit4] 2> ASYNC NEW_CORE C1605 name=collection1 org.apache.solr.core.SolrCore@6ea9cc5a
[junit4] 2> 1464522 T4572 C1605 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={masterUrl=http://127.0.0.1:50408/solr/replication&command=fetchindex&wait=true} status=0 QTime=62
[junit4] 2> 1464525 T4570 C1605 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={sort=id+desc&q=*:*&wt=javabin&version=2} hits=3 status=0 QTime=0
[junit4] 2> 1464528 T4582 oash.SnapPuller.<init> WARN 'masterUrl' must be specified without the /replication suffix
[junit4] 2> 1464528 T4582 oash.SnapPuller.<init> No value set for 'pollInterval'. Timer Task not started.
[junit4] 2> 1464529 T4575 C1605 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=indexversion&qt=/replication&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 1464529 T4582 oash.SnapPuller.fetchLatestIndex Master's generation: 2
[junit4] 2> 1464529 T4582 oash.SnapPuller.fetchLatestIndex Slave's generation: 1
[junit4] 2> 1464529 T4582 oash.SnapPuller.fetchLatestIndex Starting replication process
[junit4] 2> 1464532 T4573 C1605 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=filelist&qt=/replication&wt=javabin&generation=2&version=2} status=0 QTime=1
[junit4] 2> 1464533 T4582 oash.SnapPuller.fetchLatestIndex Number of files in latest index in master: 10
[junit4] 2> 1464533 T4582 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\collection1\data\index.20130821035603379
[junit4] 2> 1464533 T4582 oash.SnapPuller.fetchLatestIndex Starting download to MockDirWrapper(org.apache.lucene.store.RAMDirectory@56b35b72 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@22e80abd) fullCopy=false
[junit4] 2> 1464534 T4571 C1605 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.fnm&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 1464536 T4569 C1605 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0_Lucene41_0.doc&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 1464538 T4567 C1605 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.nvd&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 1464540 T4572 C1605 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=segments_2&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 1464542 T4570 C1605 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.fdx&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 1464545 T4575 C1605 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.si&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 1464547 T4573 C1605 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.nvm&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 1464550 T4571 C1605 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0_Lucene41_0.tim&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 1464552 T4569 C1605 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.fdt&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 1464554 T4567 C1605 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0_Lucene41_0.tip&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 1464554 T4582 oash.SnapPuller.fetchLatestIndex Total time taken for download : 0 secs
[junit4] 2> 1464556 T4582 oasu.DefaultSolrCoreState.closeIndexWriter Closing IndexWriter...
[junit4] 2> 1464556 T4582 oasu.DefaultSolrCoreState.closeIndexWriter Waiting until IndexWriter is unused... core=collection1
[junit4] 2> 1464556 T4582 oasu.DefaultSolrCoreState.closeIndexWriter Rollback old IndexWriter... core=collection1
[junit4] 2> 1464556 T4582 oasu.DefaultSolrCoreState.openIndexWriter Creating new IndexWriter...
[junit4] 2> 1464556 T4582 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=11, maxMergeAtOnceExplicit=47, maxMergedSegmentMB=81.43359375, floorSegmentMB=0.3310546875, forceMergeDeletesPctAllowed=24.43153721398542, segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.45210632662671635
[junit4] 2> 1464556 T4582 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=2
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@36bded46 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@19c03a89),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@36bded46 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@19c03a89),segFN=segments_2,generation=2}
[junit4] 2> 1464557 T4582 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 1464557 T4582 oasu.DefaultSolrCoreState.openIndexWriter New IndexWriter is ready to be used.
[junit4] 2> 1464557 T4582 oass.SolrIndexSearcher.<init> Opening Searcher@6bbef4ba main
[junit4] 2> 1464557 T4563 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6bbef4ba main{StandardDirectoryReader(segments_2:3:nrt _0(4.5):C3)}
[junit4] 2> 1464557 T4582 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\collection1\data\index.20130821035603379 [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\collection1\data\index.20130821035603379;done=true>>]
[junit4] 2> 1464557 T4582 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064562990\slave\collection1\data\index.20130821035603379
[junit4] 2> ASYNC NEW_CORE C1606 name=collection1 org.apache.solr.core.SolrCore@643a6c34
[junit4] 2> 1464558 T4556 C1606 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={masterUrl=http://127.0.0.1:50417/solr/replication&command=fetchindex&wait=true} status=0 QTime=31
[junit4] 2> 1464561 T4557 C1606 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={sort=id+desc&q=*:*&wt=javabin&version=2} hits=3 status=0 QTime=1
[junit4] 2> 1464564 T4536 C1604 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=details&_trace=getDetails&wt=javabin&qt=/replication&version=2} status=0 QTime=1
[junit4] 2> 1464566 T4531 C1604 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=details&_trace=getDetails&wt=javabin&qt=/replication&version=2} status=0 QTime=0
[junit4] 2> 1465206 T4572 C1605 oash.ReplicationHandler.getReplicationDetails WARN Exception while invoking 'details' method for replication on master org.apache.solr.client.solrj.SolrServerException: Server refused connection at: http://127.0.0.1:TEST_PORT/solr
[junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:429)
[junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:180)
[junit4] 2> at org.apache.solr.handler.SnapPuller.getDetails(SnapPuller.java:1596)
[junit4] 2> at org.apache.solr.handler.ReplicationHandler.getReplicationDetails(ReplicationHandler.java:639)
[junit4] 2> at org.apache.solr.handler.ReplicationHandler.handleRequestBody(ReplicationHandler.java:256)
[junit4] 2> at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:135)
[junit4] 2> at org.apache.solr.core.SolrCore.execute(SolrCore.java:1850)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.execute(SolrDispatchFilter.java:703)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:406)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:195)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1419)
[junit4] 2> at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:135)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1419)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:455)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:229)
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:137)
[junit4] 2> at org.eclipse.jetty.server.handler.GzipHandler.handle(GzipHandler.java:301)
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1077)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:384)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:193)
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1009)
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:135)
[junit4] 2> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:116)
[junit4] 2> at org.eclipse.jetty.server.Server.handle(Server.java:368)
[junit4] 2> at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:489)
[junit4] 2> at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:942)
[junit4] 2> at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:1004)
[junit4] 2> at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:640)
[junit4] 2> at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:235)
[junit4] 2> at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:82)
[junit4] 2> at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:628)
[junit4] 2> at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:52)
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
[junit4] 2> at java.lang.Thread.run(Thread.java:724)
[junit4] 2> Caused by: org.apache.http.conn.HttpHostConnectException: Connection to http://127.0.0.1 refused
[junit4] 2> at org.apache.http.impl.conn.DefaultClientConnectionOperator.openConnection(DefaultClientConnectionOperator.java:190)
[junit4] 2> at org.apache.http.impl.conn.ManagedClientConnectionImpl.open(ManagedClientConnectionImpl.java:294)
[junit4] 2> at org.apache.http.impl.client.DefaultRequestDirector.tryConnect(DefaultRequestDirector.java:645)
[junit4] 2> at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:480)
[junit4] 2> at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:906)
[junit4] 2> at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:805)
[junit4] 2> at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:784)
[junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:365)
[junit4] 2> ... 34 more
[junit4] 2> Caused by: java.net.ConnectException: Connection refused: connect
[junit4] 2> at java.net.DualStackPlainSocketImpl.waitForConnect(Native Method)
[junit4] 2> at java.net.DualStackPlainSocketImpl.socketConnect(DualStackPlainSocketImpl.java:85)
[junit4] 2> at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:345)
[junit4] 2> at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206)
[junit4] 2> at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188)
[junit4] 2> at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:172)
[junit4] 2> at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)
[junit4] 2> at java.net.Socket.connect(Socket.java:585)
[junit4] 2> at org.apache.http.conn.scheme.PlainSocketFactory.connectSocket(PlainSocketFactory.java:127)
[junit4] 2> at org.apache.http.impl.conn.DefaultClientConnectionOperator.openConnection(DefaultClientConnectionOperator.java:180)
[junit4] 2> ... 41 more
[junit4] 2>
[junit4] 2> 1465208 T4572 C1605 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=details&_trace=getDetails&wt=javabin&qt=/replication&version=2} status=0 QTime=640
[junit4] 2> 1465209 T4532 C1604 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=indexversion&_trace=assertVersions&wt=javabin&qt=/replication&version=2} status=0 QTime=0
[junit4] 2> 1465211 T4575 C1605 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=indexversion&_trace=assertVersions&wt=javabin&qt=/replication&version=2} status=0 QTime=0
[junit4] 2> 1465870 T4573 C1605 oash.ReplicationHandler.getReplicationDetails WARN Exception while invoking 'details' method for replication on master org.apache.solr.client.solrj.SolrServerException: Server refused connection at: http://127.0.0.1:TEST_PORT/solr
[junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:429)
[junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:180)
[junit4] 2> at org.apache.solr.handler.SnapPuller.getDetails(SnapPuller.java:1596)
[junit4] 2> at org.apache.solr.handler.ReplicationHandler.getReplicationDetails(ReplicationHandler.java:639)
[junit4] 2> at org.apache.solr.handler.ReplicationHandler.handleRequestBody(ReplicationHandler.java:256)
[junit4] 2> at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:135)
[junit4] 2> at org.apache.solr.core.SolrCore.execute(SolrCore.java:1850)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.execute(SolrDispatchFilter.java:703)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:406)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:195)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1419)
[junit4] 2> at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:135)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1419)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:455)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:229)
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:137)
[junit4] 2> at org.eclipse.jetty.server.handler.GzipHandler.handle(GzipHandler.java:301)
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1077)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:384)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:193)
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1009)
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:135)
[junit4] 2> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:116)
[junit4] 2> at org.eclipse.jetty.server.Server.handle(Server.java:368)
[junit4] 2> at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:489)
[junit4] 2> at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:942)
[junit4] 2> at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:1004)
[junit4] 2> at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:640)
[junit4] 2> at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:235)
[junit4] 2> at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:82)
[junit4] 2> at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:628)
[junit4] 2> at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:52)
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
[junit4] 2> at java.lang.Thread.run(Thread.java:724)
[junit4] 2> Caused by: org.apache.http.conn.HttpHostConnectException: Connection to http://127.0.0.1 refused
[junit4] 2> at org.apache.http.impl.conn.DefaultClientConnectionOperator.openConnection(DefaultClientConnectionOperator.java:190)
[junit4] 2> at org.apache.http.impl.conn.ManagedClientConnectionImpl.open(ManagedClientConnectionImpl.java:294)
[junit4] 2> at org.apache.http.impl.client.DefaultRequestDirector.tryConnect(DefaultRequestDirector.java:645)
[junit4] 2> at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:480)
[junit4] 2> at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:906)
[junit4] 2> at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:805)
[junit4] 2> at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:784)
[junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:365)
[junit4] 2> ... 34 more
[junit4] 2> Caused by: java.net.ConnectException: Connection refused: connect
[junit4] 2> at java.net.DualStackPlainSocketImpl.waitForConnect(Native Method)
[junit4] 2> at java.net.DualStackPlainSocketImpl.socketConnect(DualStackPlainSocketImpl.java:85)
[junit4] 2> at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:345)
[junit4] 2> at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206)
[junit4] 2> at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188)
[junit4] 2> at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:172)
[junit4] 2> at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)
[junit4] 2> at java.net.Socket.connect(Socket.java:585)
[junit4] 2> at org.apache.http.conn.scheme.PlainSocketFactory.connectSocket(PlainSocketFactory.java:127)
[junit4] 2> at org.apache.http.impl.conn.DefaultClientConnectionOperator.openConnection(DefaultClientConnectionOperator.java:180)
[junit4] 2> ... 41 more
[junit4] 2>
[junit4] 2> 1465870 T4573 C1605 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=details&_trace=getDetails&wt=javabin&qt=/replication&version=2} status=0 QTime=657
[junit4] 2> 1466525 T4569 C1605 oash.ReplicationHandler.getReplicationDetails WARN Exception while invoking 'details' method for replication on master org.apache.solr.client.solrj.SolrServerException: Server refused connection at: http://127.0.0.1:TEST_PORT/solr
[junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:429)
[junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:180)
[junit4] 2> at org.apache.solr.handler.SnapPuller.getDetails(SnapPuller.java:1596)
[junit4] 2> at org.apache.solr.handler.ReplicationHandler.getReplicationDetails(ReplicationHandler.java:639)
[junit4] 2> at org.apache.solr.handler.ReplicationHandler.handleRequestBody(ReplicationHandler.java:256)
[junit4] 2> at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:135)
[junit4] 2> at org.apache.solr.core.SolrCore.execute(SolrCore.java:1850)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.execute(SolrDispatchFilter.java:703)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:406)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:195)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1419)
[junit4] 2> at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:135)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1419)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:455)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:229)
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:137)
[junit4] 2> at org.eclipse.jetty.server.handler.GzipHandler.handle(GzipHandler.java:301)
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1077)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:384)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:193)
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1009)
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:135)
[junit4] 2> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:116)
[junit4] 2> at org.eclipse.jetty.server.Server.handle(Server.java:368)
[junit4] 2> at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:489)
[junit4] 2> at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:942)
[junit4] 2> at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:1004)
[junit4] 2> at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:640)
[junit4] 2> at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:235)
[junit4] 2> at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:82)
[junit4] 2> at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:628)
[junit4] 2> at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:52)
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
[junit4] 2> at java.lang.Thread.run(Thread.java:724)
[junit4] 2> Caused by: org.apache.http.conn.HttpHostConnectException: Connection to http://127.0.0.1 refused
[junit4] 2> at org.apache.http.impl.conn.DefaultClientConnectionOperator.openConnection(DefaultClientConnectionOperator.java:190)
[junit4] 2> at org.apache.http.impl.conn.ManagedClientConnectionImpl.open(ManagedClientConnectionImpl.java:294)
[junit4] 2> at org.apache.http.impl.client.DefaultRequestDirector.tryConnect(DefaultRequestDirector.java:645)
[junit4] 2> at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:480)
[junit4] 2> at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:906)
[junit4] 2> at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:805)
[junit4] 2> at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:784)
[junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:365)
[junit4] 2> ... 34 more
[junit4] 2> Caused by: java.net.ConnectException: Connection refused: connect
[junit4] 2> at java.net.DualStackPlainSocketImpl.waitForConnect(Native Method)
[junit4] 2> at java.net.DualStackPlainSocketImpl.socketConnect(DualStackPlainSocketImpl.java:85)
[junit4] 2> at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:345)
[junit4] 2> at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206)
[junit4] 2> at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188)
[junit4] 2> at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:172)
[junit4] 2> at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)
[junit4] 2> at java.net.Socket.connect(Socket.java:585)
[junit4] 2> at org.apache.http.conn.scheme.PlainSocketFactory.connectSocket(PlainSocketFactory.java:127)
[junit4] 2> at org.apache.http.impl.conn.DefaultClientConnectionOperator.openConnection(DefaultClientConnectionOperator.java:180)
[junit4] 2> ... 41 more
[junit4] 2>
[junit4] 2> 1466528 T4569 C1605 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=details&_trace=getDetails&wt=javabin&qt=/replication&version=2} status=0 QTime=656
[junit4] 2> 1466531 T4570 C1605 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={slave=false&command=details&wt=javabin&qt=/replication&version=2} status=0 QTime=0
[junit4] 2> 1466532 T4556 C1606 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=details&_trace=getDetails&wt=javabin&qt=/replication&version=2} status=0 QTime=3
[junit4] 2> 1466537 T4575 C1605 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=indexversion&_trace=assertVersions&wt=javabin&qt=/replication&version=2} status=0 QTime=0
[junit4] 2> 1466539 T4557 C1606 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=indexversion&_trace=assertVersions&wt=javabin&qt=/replication&version=2} status=0 QTime=0
[junit4] 2> 1466541 T4571 C1605 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0]} 0 0
[junit4] 2> 1466543 T4573 C1605 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1]} 0 0
[junit4] 2> 1466545 T4567 C1605 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2]} 0 0
[junit4] 2> 1466548 T4569 C1605 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[3]} 0 0
[junit4] 2> 1466549 T4570 C1605 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1466551 T4570 C1605 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@184fd43d lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@9aaf4d4),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@184fd43d lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@9aaf4d4),segFN=segments_3,generation=3}
[junit4] 2> 1466551 T4570 C1605 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 1466552 T4570 C1605 oass.SolrIndexSearcher.<init> Opening Searcher@7a9ad536 main
[junit4] 2> 1466552 T4570 C1605 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 1466553 T4577 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7a9ad536 main{StandardDirectoryReader(segments_3:7:nrt _1(4.5):C4)}
[junit4] 2> 1466555 T4570 C1605 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 6
[junit4] 2> 1466557 T4584 oash.SnapPuller.<init> WARN 'masterUrl' must be specified without the /replication suffix
[junit4] 2> 1466557 T4584 oash.SnapPuller.<init> No value set for 'pollInterval'. Timer Task not started.
[junit4] 2> 1466559 T4536 C1604 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=indexversion&qt=/replication&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1466559 T4584 oash.SnapPuller.fetchLatestIndex Master's generation: 2
[junit4] 2> 1466560 T4584 oash.SnapPuller.fetchLatestIndex Slave's generation: 3
[junit4] 2> 1466560 T4584 oash.SnapPuller.fetchLatestIndex Starting replication process
[junit4] 2> 1466561 T4531 C1604 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=filelist&qt=/replication&wt=javabin&generation=2&version=2} status=0 QTime=0
[junit4] 2> 1466562 T4584 oash.SnapPuller.fetchLatestIndex Number of files in latest index in master: 10
[junit4] 2> 1466563 T4584 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064563219\repeater\collection1\data\index.20130821035605408
[junit4] 2> 1466563 T4584 oash.SnapPuller.fetchLatestIndex Starting download to MockDirWrapper(org.apache.lucene.store.RAMDirectory@2ee78ddb lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4c6408bb) fullCopy=true
[junit4] 2> 1466565 T4533 C1604 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.fnm&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 1466567 T4532 C1604 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0_Lucene41_0.doc&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 1466570 T4534 C1604 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.nvd&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 1466572 T4535 C1604 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=segments_2&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 1466575 T4536 C1604 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.fdx&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 1466577 T4531 C1604 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.nvm&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 1466580 T4533 C1604 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.si&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 1466582 T4532 C1604 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0_Lucene41_0.tim&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 1466585 T4534 C1604 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0_Lucene41_0.tip&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 1466587 T4535 C1604 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.fdt&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 1466588 T4584 oash.SnapPuller.fetchLatestIndex Total time taken for download : 0 secs
[junit4] 2> 1466589 T4584 oash.SnapPuller.modifyIndexProps New index installed. Updating index properties... index=index.20130821035605408
[junit4] 2> 1466590 T4584 oash.SnapPuller.fetchLatestIndex removing old index directory BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@184fd43d lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@9aaf4d4)
[junit4] 2> 1466590 T4584 oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
[junit4] 2> 1466590 T4584 oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused... core=collection1
[junit4] 2> 1466590 T4584 oasu.DefaultSolrCoreState.newIndexWriter Rollback old IndexWriter... core=collection1
[junit4] 2> 1466591 T4584 oasc.SolrCore.getNewIndexDir New index directory detected: old=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064563219\repeater\collection1\data\index/ new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064563219\repeater\collection1\data\index.20130821035605408
[junit4] 2> 1466591 T4584 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=11, maxMergeAtOnceExplicit=47, maxMergedSegmentMB=81.43359375, floorSegmentMB=0.3310546875, forceMergeDeletesPctAllowed=24.43153721398542, segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.45210632662671635
[junit4] 2> 1466592 T4584 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@2ee78ddb lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4c6408bb),segFN=segments_2,generation=2}
[junit4] 2> 1466592 T4584 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 1466592 T4584 oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
[junit4] 2> 1466592 T4584 oass.SolrIndexSearcher.<init> Opening Searcher@46324cf9 main
[junit4] 2> 1466593 T4577 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@46324cf9 main{StandardDirectoryReader(segments_2:3:nrt _0(4.5):C3)}
[junit4] 2> 1466593 T4572 C1605 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={masterUrl=http://127.0.0.1:50408/solr/replication&command=fetchindex&wait=true} status=0 QTime=37
[junit4] 2> 1466594 T4572 C1605 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064563219\repeater\collection1\data\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064563219\repeater\collection1\data\index;done=true>>]
[junit4] 2> 1466594 T4572 C1605 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064563219\repeater\collection1\data\index
[junit4] 2> 1466595 T4575 C1605 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={sort=id+desc&q=*:*&wt=javab
[...truncated too long message...]
90 T4527 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064618414\master\collection1\data\
[junit4] 2> 1521490 T4527 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 1521556 T4527 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=665883035
[junit4] 2> 1521558 T4527 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@36f81627
[junit4] 2> 1521558 T4527 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=5,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=5,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 1521559 T4527 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 1521559 T4527 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 1521560 T4527 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 1521561 T4527 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 1521561 T4527 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 1521561 T4527 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064618578\slave\collection1\data\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064618578\slave\collection1\data\index;done=false>>]
[junit4] 2> 1521561 T4527 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064618578\slave\collection1\data\index
[junit4] 2> 1521563 T4527 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064618578\slave\collection1\data\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064618578\slave\collection1\data\;done=false>>]
[junit4] 2> 1521565 T4527 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1377064618578\slave\collection1\data\
[junit4] 2> 1521565 T4527 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 1521643 T4527 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 57611 T4526 ccr.ThreadLeakControl.checkThreadLeaks WARNING Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> 1522503 T5225 oash.SnapPuller.fetchLatestIndex ERROR Master at: http://127.0.0.1:50618/solr is not available. Index fetch failed. Exception: org.apache.solr.client.solrj.SolrServerException: Server refused connection at: http://127.0.0.1:50618/solr
[junit4] 2> 1522504 T5225 oasc.SolrException.log ERROR SnapPull failed :org.apache.lucene.store.AlreadyClosedException: Already closed
[junit4] 2> at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:340)
[junit4] 2> at org.apache.solr.handler.ReplicationHandler.loadReplicationProperties(ReplicationHandler.java:808)
[junit4] 2> at org.apache.solr.handler.SnapPuller.logReplicationTimeAndConfFiles(SnapPuller.java:546)
[junit4] 2> at org.apache.solr.handler.SnapPuller.fetchLatestIndex(SnapPuller.java:488)
[junit4] 2> at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:319)
[junit4] 2> at org.apache.solr.handler.ReplicationHandler$1.run(ReplicationHandler.java:220)
[junit4] 2>
[junit4] 2> NOTE: test params are: codec=Lucene42, sim=RandomSimilarityProvider(queryNorm=true,coord=crazy): {}, locale=es_DO, timezone=America/Noronha
[junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0-ea (64-bit)/cpus=2,threads=1,free=132806824,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [TestRTGBase, TestMergePolicyConfig, CircularListTest, OutputWriterTest, RAMDirectoryFactoryTest, HardAutoCommitTest, ResponseLogComponentTest, TestCoreContainer, WordBreakSolrSpellCheckerTest, ResourceLoaderTest, XsltUpdateRequestHandlerTest, TestPerFieldSimilarity, SolrXmlInZkTest, TestSolrXmlPersistence, TestDefaultSearchFieldResource, BasicDistributedZk2Test, PluginInfoTest, SolrIndexSplitterTest, TestImplicitCoreProperties, TestExtendedDismaxParser, TestUniqueKeyFieldResource, TestPhraseSuggestions, RecoveryZkTest, TestCopyFieldCollectionResource, HdfsCollectionsAPIDistributedZkTest, TermVectorComponentTest, DateFieldTest, ShardRoutingCustomTest, AddBlockUpdateTest, HdfsBasicDistributedZkTest, TestGroupingSearch, TestFunctionQuery, TestDistributedSearch, TestZkChroot, SpatialFilterTest, TestSolrQueryParserDefaultOperatorResource, TestRealTimeGet, TestRangeQuery, UpdateRequestProcessorFactoryTest, TestBadConfig, SuggesterFSTTest, CoreAdminCreateDiscoverTest, TestSolrCoreProperties, SoftAutoCommitTest, TestElisionMultitermQuery, SortByFunctionTest, CoreMergeIndexesAdminHandlerTest, TestNRTOpen, BJQParserTest, CachingDirectoryFactoryTest, SearchHandlerTest, AliasIntegrationTest, TestFieldTypeResource, TestSchemaNameResource, TestCoreDiscovery, TestReversedWildcardFilterFactory, MBeansHandlerTest, FileBasedSpellCheckerTest, BasicDistributedZkTest, TestQueryUtils, DirectSolrSpellCheckerTest, TestCharFilters, TestSerializedLuceneMatchVersion, DocValuesTest, HdfsDirectoryTest, StatelessScriptUpdateProcessorFactoryTest, TestFastWriter, TestPHPSerializedResponseWriter, TestJmxMonitoredMap, FileUtilsTest, DirectUpdateHandlerTest, TestMultiCoreConfBootstrap, TestPseudoReturnFields, SliceStateUpdateTest, TestInfoStreamLogging, OpenExchangeRatesOrgProviderTest, FieldAnalysisRequestHandlerTest, ClusterStateUpdateTest, TestSuggestSpellingConverter, TestFiltering, TestDistributedGrouping, TestStressVersions, TestSweetSpotSimilarityFactory, TestMaxScoreQueryParser, TestCollationField, QueryParsingTest, AnalysisAfterCoreReloadTest, TestOmitPositions, TestSolrXml, HdfsUnloadDistributedZkTest, InfoHandlerTest, NumericFieldsTest, HdfsSyncSliceTest, ZkSolrClientTest, TestFieldCollectionResource, TestQueryTypes, TestSolrXMLSerializer, TermVectorComponentDistributedTest, TestConfig, SolrPluginUtilsTest, ParsingFieldUpdateProcessorsTest, TestFaceting, BadCopyFieldTest, TermsComponentTest, DirectUpdateHandlerOptimizeTest, URLClassifyProcessorTest, SynonymTokenizerTest, TestAtomicUpdateErrorCases, TestSolrDeletionPolicy1, TestHashPartitioner, AutoCommitTest, SignatureUpdateProcessorFactoryTest, OverseerCollectionProcessorTest, SOLR749Test, TestFuzzyAnalyzedSuggestions, TestRandomDVFaceting, TestDynamicFieldCollectionResource, IndexSchemaRuntimeFieldTest, TestIndexingPerformance, ChaosMonkeyNothingIsSafeTest, DocumentBuilderTest, SuggesterTest, TestDocSet, CoreAdminHandlerTest, TestCSVResponseWriter, LoggingHandlerTest, TestSolrQueryParser, ZkCLITest, PrimUtilsTest, QueryEqualityTest, LukeRequestHandlerTest, AlternateDirectoryTest, CoreContainerCoreInitFailuresTest, TestAddFieldRealTimeGet, StandardRequestHandlerTest, EchoParamsTest, TestRandomMergePolicy, SolrRequestParserTest, TestPartialUpdateDeduplication, MoreLikeThisHandlerTest, QueryElevationComponentTest, TestDynamicFieldResource, SuggesterTSTTest, DefaultValueUpdateProcessorTest, TestClassNameShortening, ShardSplitTest, BlockCacheTest, TestTrie, SpellCheckCollatorTest, TestStressRecovery, TestDFRSimilarityFactory, BadIndexSchemaTest, SimpleFacetsTest, PreAnalyzedFieldTest, MultiTermTest, DebugComponentTest, ChaosMonkeySafeLeaderTest, UnloadDistributedZkTest, CollectionsAPIDistributedZkTest, SyncSliceTest, OpenCloseCoreStressTest, OverseerTest, LeaderElectionIntegrationTest, ShardRoutingTest, BasicZkTest, TestReplicationHandler]
[junit4] Completed in 58.66s, 14 tests, 1 failure <<< FAILURES!
[...truncated 470 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:395: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:375: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:39: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build.xml:181: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\common-build.xml:450: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\lucene\common-build.xml:1233: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\lucene\common-build.xml:876: There were test failures: 324 suites, 1406 tests, 1 failure, 44 ignored (11 assumptions)
Total time: 63 minutes 14 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/jdk1.8.0-ea-b102 -XX:+UseCompressedOops -XX:+UseG1GC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure