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/12 07:02:38 UTC
[JENKINS] Lucene-Solr-4.x-Windows (64bit/jdk1.6.0_45) - Build #
3069 - Still Failing!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Windows/3069/
Java: 64bit/jdk1.6.0_45 -XX:+UseCompressedOops -XX:+UseSerialGC
1 tests failed.
REGRESSION: org.apache.solr.handler.TestReplicationHandler.doTestBackup
Error Message:
Backup success not detected:<?xml version="1.0" encoding="UTF-8"?> <response> <lst name="responseHeader"><int name="status">0</int><int name="QTime">0</int></lst><lst name="details"><str name="indexSize">21.75 KB</str><str name="indexPath">C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282526642\master\collection1\data\index/</str><arr name="commits"><lst><long name="indexVersion">1376282528982</long><long name="generation">2</long><arr name="filelist"><str>_0.cfe</str><str>_0.cfs</str><str>_0.si</str><str>segments_2</str></arr></lst></arr><str name="isMaster">true</str><str name="isSlave">false</str><long name="indexVersion">1376282528982</long><long name="generation">2</long><lst name="master"><str name="confFiles">schema-replication2.xml:schema.xml</str><arr name="replicateAfter"><str>commit</str></arr><str name="replicationEnabled">true</str><long name="replicableVersion">1376282528982</long><long name="replicableGeneration">2</long></lst><lst name="backup"><str name="startTime">Mon Aug 12 14:42:09 EST 2013</str><int name="fileCount">4</int><str name="status">success</str><str name="snapshotCompletedAt">Mon Aug 12 14:42:09 EST 2013</str></lst></lst><str name="WARNING">This response format is experimental. It is likely to change in the future.</str> </response>
Stack Trace:
java.lang.AssertionError: Backup success not detected:<?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader"><int name="status">0</int><int name="QTime">0</int></lst><lst name="details"><str name="indexSize">21.75 KB</str><str name="indexPath">C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282526642\master\collection1\data\index/</str><arr name="commits"><lst><long name="indexVersion">1376282528982</long><long name="generation">2</long><arr name="filelist"><str>_0.cfe</str><str>_0.cfs</str><str>_0.si</str><str>segments_2</str></arr></lst></arr><str name="isMaster">true</str><str name="isSlave">false</str><long name="indexVersion">1376282528982</long><long name="generation">2</long><lst name="master"><str name="confFiles">schema-replication2.xml:schema.xml</str><arr name="replicateAfter"><str>commit</str></arr><str name="replicationEnabled">true</str><long name="replicableVersion">1376282528982</long><long name="replicableGeneration">2</long></lst><lst name="backup"><str name="startTime">Mon Aug 12 14:42:09 EST 2013</str><int name="fileCount">4</int><str name="status">success</str><str name="snapshotCompletedAt">Mon Aug 12 14:42:09 EST 2013</str></lst></lst><str name="WARNING">This response format is experimental. It is likely to change in the future.</str>
</response>
at __randomizedtesting.SeedInfo.seed([8ABE15EEA4AE81B3:CB35358B831072FC]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.apache.solr.handler.TestReplicationHandler.doTestBackup(TestReplicationHandler.java:1395)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:597)
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:662)
Build Log:
[...truncated 9285 lines...]
[junit4] Suite: org.apache.solr.handler.TestReplicationHandler
[junit4] 2> 2426315 T5594 oas.SolrTestCaseJ4.setUp ###Starting doTestDetails
[junit4] 2> 2426329 T5594 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 2426335 T5594 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:57204
[junit4] 2> 2426336 T5594 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 2426336 T5594 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 2426336 T5594 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282518827\master
[junit4] 2> 2426337 T5594 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282518827\master\'
[junit4] 2> 2426362 T5594 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-1376282518827\master\solr.xml
[junit4] 2> 2426364 T5594 oasc.ConfigSolr.fromFile C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282518827\master\solr.xml does not exist, using default configuration
[junit4] 2> 2426428 T5594 oasc.CoreContainer.<init> New CoreContainer 1937434737
[junit4] 2> 2426428 T5594 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282518827\master\]
[junit4] 2> 2426429 T5594 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 2426429 T5594 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 2426430 T5594 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 2426430 T5594 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 2426430 T5594 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 2426431 T5594 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 2426431 T5594 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 2426431 T5594 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 2426431 T5594 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 2426432 T5594 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 2426446 T5604 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282518827\master\collection1
[junit4] 2> 2426446 T5604 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282518827\master\collection1\'
[junit4] 2> 2426522 T5604 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_45
[junit4] 2> 2426583 T5604 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 2426583 T5604 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 2426589 T5604 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 2426611 T5604 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 2426613 T5604 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 2426613 T5604 oasc.SolrCore.<init> [collection1] Opening new SolrCore at .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282518827\master\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282518827\master\collection1\data\
[junit4] 2> 2426613 T5604 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 2426613 T5604 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-1376282518827\master\collection1\data\
[junit4] 2> 2426613 T5604 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-1376282518827\master\collection1\data\index/
[junit4] 2> 2426613 T5604 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-1376282518827\master\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 2426614 T5604 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-1376282518827\master\collection1\data\index
[junit4] 2> 2426615 T5604 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@6f03ec19 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@36b52bc9),segFN=segments_1,generation=1}
[junit4] 2> 2426615 T5604 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 2426617 T5604 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 2426617 T5604 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 2426618 T5604 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 2426618 T5604 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 2426618 T5604 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 2426618 T5604 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 2426624 T5604 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2426626 T5604 oass.SolrIndexSearcher.<init> Opening Searcher@47abced0 main
[junit4] 2> 2426626 T5604 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 2426626 T5604 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 2426626 T5604 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 2426626 T5604 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 2426627 T5604 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 2426628 T5605 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@47abced0 main{StandardDirectoryReader(segments_1:1)}
[junit4] 2> 2426628 T5594 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 2426628 T5594 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 2426629 T5594 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> 2426644 T5594 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 2426647 T5594 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:57207
[junit4] 2> 2426647 T5594 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 2426649 T5594 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 2426649 T5594 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282519145\slave
[junit4] 2> 2426649 T5594 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282519145\slave\'
[junit4] 2> 2426664 T5594 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-1376282519145\slave\solr.xml
[junit4] 2> 2426665 T5594 oasc.ConfigSolr.fromFile C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282519145\slave\solr.xml does not exist, using default configuration
[junit4] 2> 2426726 T5594 oasc.CoreContainer.<init> New CoreContainer 97874532
[junit4] 2> 2426726 T5594 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282519145\slave\]
[junit4] 2> 2426728 T5594 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 2426728 T5594 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 2426728 T5594 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 2426729 T5594 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 2426729 T5594 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 2426730 T5594 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 2426730 T5594 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 2426730 T5594 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 2426731 T5594 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 2426731 T5594 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 2426741 T5616 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282519145\slave\collection1
[junit4] 2> 2426741 T5616 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282519145\slave\collection1\'
[junit4] 2> 2426813 T5616 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_45
[junit4] 2> 2426869 T5616 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 2426869 T5616 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 2426876 T5616 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 2426896 T5616 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 2426897 T5616 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 2426897 T5616 oasc.SolrCore.<init> [collection1] Opening new SolrCore at .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282519145\slave\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282519145\slave\collection1\data\
[junit4] 2> 2426898 T5616 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 2426898 T5616 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-1376282519145\slave\collection1\data\
[junit4] 2> 2426898 T5616 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-1376282519145\slave\collection1\data\index/
[junit4] 2> 2426898 T5616 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-1376282519145\slave\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 2426899 T5616 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-1376282519145\slave\collection1\data\index
[junit4] 2> 2426899 T5616 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@11ae29f9 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f2fde6b),segFN=segments_1,generation=1}
[junit4] 2> 2426899 T5616 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 2426900 T5616 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 2426900 T5616 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 2426900 T5616 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 2426900 T5616 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 2426901 T5616 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 2426901 T5616 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 2426903 T5616 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2426906 T5616 oass.SolrIndexSearcher.<init> Opening Searcher@3677da68 main
[junit4] 2> 2426906 T5616 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 2426906 T5616 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 2426907 T5616 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
[junit4] 2> 2426907 T5616 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 2426907 T5617 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3677da68 main{StandardDirectoryReader(segments_1:1)}
[junit4] 2> 2426908 T5594 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 2426908 T5594 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 2426909 T5594 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> ASYNC NEW_CORE C5125 name=collection1 org.apache.solr.core.SolrCore@331d09e3
[junit4] 2> 2426921 T5599 C5125 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={sort=id+desc&q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=1
[junit4] 2> 2426924 T5600 C5125 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> 2426938 T5601 C5125 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> ASYNC NEW_CORE C5126 name=collection1 org.apache.solr.core.SolrCore@282f439b
[junit4] 2> 2426939 T5610 C5126 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=details&_trace=getDetails&wt=javabin&qt=/replication&version=2} status=0 QTime=4
[junit4] 2> 2426942 T5602 C5125 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@6f03ec19 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@36b52bc9),segFN=segments_1,generation=1}
[junit4] 2> 2426943 T5602 C5125 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 2426943 T5602 C5125 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0]} 0 2
[junit4] 2> 2426945 T5603 C5125 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2426946 T5603 C5125 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@6f03ec19 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@36b52bc9),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@6f03ec19 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@36b52bc9),segFN=segments_2,generation=2}
[junit4] 2> 2426946 T5603 C5125 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 2426947 T5603 C5125 oass.SolrIndexSearcher.<init> Opening Searcher@479fcab5 main
[junit4] 2> 2426948 T5603 C5125 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 2426948 T5605 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@479fcab5 main{StandardDirectoryReader(segments_2:3:nrt _0(4.5):c1)}
[junit4] 2> 2426949 T5603 C5125 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 4
[junit4] 2> 2426951 T5620 oash.SnapPuller.<init> WARN 'masterUrl' must be specified without the /replication suffix
[junit4] 2> 2426951 T5620 oash.SnapPuller.<init> No value set for 'pollInterval'. Timer Task not started.
[junit4] 2> 2426953 T5598 C5125 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=indexversion&qt=/replication&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 2426954 T5620 oash.SnapPuller.fetchLatestIndex Master's generation: 2
[junit4] 2> 2426954 T5620 oash.SnapPuller.fetchLatestIndex Slave's generation: 1
[junit4] 2> 2426954 T5620 oash.SnapPuller.fetchLatestIndex Starting replication process
[junit4] 2> 2426958 T5599 C5125 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=filelist&qt=/replication&wt=javabin&generation=2&version=2} status=0 QTime=2
[junit4] 2> 2426959 T5620 oash.SnapPuller.fetchLatestIndex Number of files in latest index in master: 4
[junit4] 2> 2426960 T5620 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-1376282519145\slave\collection1\data\index.20130812144159470
[junit4] 2> 2426960 T5620 oash.SnapPuller.fetchLatestIndex Starting download to MockDirWrapper(org.apache.lucene.store.RAMDirectory@236149a9 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7d7fb85d) fullCopy=false
[junit4] 2> 2426961 T5600 C5125 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.cfs&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 2426965 T5601 C5125 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_0.cfe&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=2} status=0 QTime=0
[junit4] 2> 2426968 T5602 C5125 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> 2426972 T5603 C5125 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> 2426973 T5620 oash.SnapPuller.fetchLatestIndex Total time taken for download : 0 secs
[junit4] 2> 2426975 T5620 oasu.DefaultSolrCoreState.closeIndexWriter Closing IndexWriter...
[junit4] 2> 2426975 T5620 oasu.DefaultSolrCoreState.closeIndexWriter Waiting until IndexWriter is unused... core=collection1
[junit4] 2> 2426975 T5620 oasu.DefaultSolrCoreState.openIndexWriter Creating new IndexWriter...
[junit4] 2> 2426976 T5620 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=2
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@11ae29f9 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f2fde6b),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@11ae29f9 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f2fde6b),segFN=segments_2,generation=2}
[junit4] 2> 2426976 T5620 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 2426976 T5620 oasu.DefaultSolrCoreState.openIndexWriter New IndexWriter is ready to be used.
[junit4] 2> 2426977 T5620 oass.SolrIndexSearcher.<init> Opening Searcher@78664e55 main
[junit4] 2> 2426978 T5617 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@78664e55 main{StandardDirectoryReader(segments_2:3:nrt _0(4.5):c1)}
[junit4] 2> 2426978 T5620 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-1376282519145\slave\collection1\data\index.20130812144159470 [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-1376282519145\slave\collection1\data\index.20130812144159470;done=true>>]
[junit4] 2> 2426978 T5620 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-1376282519145\slave\collection1\data\index.20130812144159470
[junit4] 2> 2426979 T5611 C5126 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={masterUrl=http://127.0.0.1:57204/solr/replication&command=fetchindex&wait=true} status=0 QTime=29
[junit4] 2> 2426985 T5598 C5125 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> 2426987 T5612 C5126 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=details&_trace=getDetails&wt=javabin&qt=/replication&version=2} status=0 QTime=5
[junit4] 2> 2426990 T5599 C5125 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1]} 0 1
[junit4] 2> 2426992 T5600 C5125 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2426995 T5600 C5125 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@6f03ec19 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@36b52bc9),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@6f03ec19 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@36b52bc9),segFN=segments_3,generation=3}
[junit4] 2> 2426995 T5600 C5125 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 2426997 T5600 C5125 oass.SolrIndexSearcher.<init> Opening Searcher@2caed897 main
[junit4] 2> 2426998 T5600 C5125 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 2426998 T5605 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2caed897 main{StandardDirectoryReader(segments_3:5:nrt _0(4.5):c1 _1(4.5):c1)}
[junit4] 2> 2427000 T5600 C5125 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 8
[junit4] 2> 2427002 T5623 oash.SnapPuller.<init> WARN 'masterUrl' must be specified without the /replication suffix
[junit4] 2> 2427002 T5623 oash.SnapPuller.<init> No value set for 'pollInterval'. Timer Task not started.
[junit4] 2> 2427005 T5601 C5125 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=indexversion&qt=/replication&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 2427005 T5623 oash.SnapPuller.fetchLatestIndex Master's generation: 3
[junit4] 2> 2427005 T5623 oash.SnapPuller.fetchLatestIndex Slave's generation: 2
[junit4] 2> 2427005 T5623 oash.SnapPuller.fetchLatestIndex Starting replication process
[junit4] 2> 2427009 T5602 C5125 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=filelist&qt=/replication&wt=javabin&generation=3&version=2} status=0 QTime=1
[junit4] 2> 2427010 T5623 oash.SnapPuller.fetchLatestIndex Number of files in latest index in master: 7
[junit4] 2> 2427010 T5623 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-1376282519145\slave\collection1\data\index.20130812144159521
[junit4] 2> 2427010 T5623 oash.SnapPuller.fetchLatestIndex Starting download to MockDirWrapper(org.apache.lucene.store.RAMDirectory@74180a67 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@76b7a440) fullCopy=false
[junit4] 2> 2427011 T5623 oash.SnapPuller.downloadIndexFiles Skipping download for _0.cfs because it already exists
[junit4] 2> 2427012 T5623 oash.SnapPuller.downloadIndexFiles Skipping download for _0.cfe because it already exists
[junit4] 2> 2427014 T5603 C5125 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_1.si&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=3} status=0 QTime=0
[junit4] 2> 2427016 T5623 oash.SnapPuller.downloadIndexFiles Skipping download for _0.si because it already exists
[junit4] 2> 2427018 T5598 C5125 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_1.cfs&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=3} status=0 QTime=0
[junit4] 2> 2427021 T5599 C5125 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=segments_3&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=3} status=0 QTime=0
[junit4] 2> 2427025 T5600 C5125 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_1.cfe&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=3} status=0 QTime=0
[junit4] 2> 2427027 T5623 oash.SnapPuller.fetchLatestIndex Total time taken for download : 0 secs
[junit4] 2> 2427031 T5623 oasu.DefaultSolrCoreState.closeIndexWriter Closing IndexWriter...
[junit4] 2> 2427031 T5623 oasu.DefaultSolrCoreState.closeIndexWriter Waiting until IndexWriter is unused... core=collection1
[junit4] 2> 2427032 T5623 oasu.DefaultSolrCoreState.closeIndexWriter Rollback old IndexWriter... core=collection1
[junit4] 2> 2427034 T5623 oasu.DefaultSolrCoreState.openIndexWriter Creating new IndexWriter...
[junit4] 2> 2427035 T5623 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=2
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@11ae29f9 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f2fde6b),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@11ae29f9 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f2fde6b),segFN=segments_3,generation=3}
[junit4] 2> 2427036 T5623 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 2427036 T5623 oasu.DefaultSolrCoreState.openIndexWriter New IndexWriter is ready to be used.
[junit4] 2> 2427039 T5623 oass.SolrIndexSearcher.<init> Opening Searcher@531e286a main
[junit4] 2> 2427039 T5617 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@531e286a main{StandardDirectoryReader(segments_3:5:nrt _0(4.5):c1 _1(4.5):c1)}
[junit4] 2> 2427040 T5623 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-1376282519145\slave\collection1\data\index.20130812144159521 [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-1376282519145\slave\collection1\data\index.20130812144159521;done=true>>]
[junit4] 2> 2427040 T5623 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-1376282519145\slave\collection1\data\index.20130812144159521
[junit4] 2> 2427041 T5613 C5126 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={masterUrl=http://127.0.0.1:57204/solr/replication&command=fetchindex&wait=true} status=0 QTime=40
[junit4] 2> 2427047 T5601 C5125 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> 2427050 T5614 C5126 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=details&_trace=getDetails&wt=javabin&qt=/replication&version=2} status=0 QTime=6
[junit4] 2> 2427053 T5602 C5125 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2]} 0 1
[junit4] 2> 2427057 T5603 C5125 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2427060 T5603 C5125 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=3
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@6f03ec19 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@36b52bc9),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@6f03ec19 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@36b52bc9),segFN=segments_3,generation=3}
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@6f03ec19 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@36b52bc9),segFN=segments_4,generation=4}
[junit4] 2> 2427060 T5603 C5125 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 4
[junit4] 2> 2427062 T5603 C5125 oass.SolrIndexSearcher.<init> Opening Searcher@182dc007 main
[junit4] 2> 2427063 T5603 C5125 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 2427063 T5605 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@182dc007 main{StandardDirectoryReader(segments_4:7:nrt _0(4.5):c1 _1(4.5):c1 _2(4.5):c1)}
[junit4] 2> 2427065 T5603 C5125 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 9
[junit4] 2> 2427066 T5625 oash.SnapPuller.<init> WARN 'masterUrl' must be specified without the /replication suffix
[junit4] 2> 2427066 T5625 oash.SnapPuller.<init> No value set for 'pollInterval'. Timer Task not started.
[junit4] 2> 2427068 T5598 C5125 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=indexversion&qt=/replication&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 2427069 T5625 oash.SnapPuller.fetchLatestIndex Master's generation: 4
[junit4] 2> 2427069 T5625 oash.SnapPuller.fetchLatestIndex Slave's generation: 3
[junit4] 2> 2427070 T5625 oash.SnapPuller.fetchLatestIndex Starting replication process
[junit4] 2> 2427074 T5599 C5125 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=filelist&qt=/replication&wt=javabin&generation=4&version=2} status=0 QTime=2
[junit4] 2> 2427075 T5625 oash.SnapPuller.fetchLatestIndex Number of files in latest index in master: 10
[junit4] 2> 2427076 T5625 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-1376282519145\slave\collection1\data\index.20130812144159587
[junit4] 2> 2427076 T5625 oash.SnapPuller.fetchLatestIndex Starting download to MockDirWrapper(org.apache.lucene.store.RAMDirectory@33127c03 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@22b948f2) fullCopy=false
[junit4] 2> 2427080 T5600 C5125 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_2.si&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=4} status=0 QTime=1
[junit4] 2> 2427081 T5625 oash.SnapPuller.downloadIndexFiles Skipping download for _0.cfs because it already exists
[junit4] 2> 2427081 T5625 oash.SnapPuller.downloadIndexFiles Skipping download for _0.cfe because it already exists
[junit4] 2> 2427081 T5625 oash.SnapPuller.downloadIndexFiles Skipping download for _1.si because it already exists
[junit4] 2> 2427081 T5625 oash.SnapPuller.downloadIndexFiles Skipping download for _0.si because it already exists
[junit4] 2> 2427081 T5625 oash.SnapPuller.downloadIndexFiles Skipping download for _1.cfs because it already exists
[junit4] 2> 2427085 T5601 C5125 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_2.cfs&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=4} status=0 QTime=0
[junit4] 2> ASYNC NEW_CORE C5127 name=collection1 org.apache.solr.core.SolrCore@331d09e3
[junit4] 2> 2427102 T5602 C5127 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=_2.cfe&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=4} status=0 QTime=0
[junit4] 2> 2427105 T5603 C5127 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={file=segments_4&command=filecontent&checksum=true&wt=filestream&qt=/replication&generation=4} status=0 QTime=0
[junit4] 2> 2427105 T5625 oash.SnapPuller.downloadIndexFiles Skipping download for _1.cfe because it already exists
[junit4] 2> 2427106 T5625 oash.SnapPuller.fetchLatestIndex Total time taken for download : 0 secs
[junit4] 2> 2427107 T5625 oasu.DefaultSolrCoreState.closeIndexWriter Closing IndexWriter...
[junit4] 2> 2427107 T5625 oasu.DefaultSolrCoreState.closeIndexWriter Waiting until IndexWriter is unused... core=collection1
[junit4] 2> 2427107 T5625 oasu.DefaultSolrCoreState.closeIndexWriter Rollback old IndexWriter... core=collection1
[junit4] 2> 2427108 T5625 oasu.DefaultSolrCoreState.openIndexWriter Creating new IndexWriter...
[junit4] 2> 2427157 T5625 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=2
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@11ae29f9 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f2fde6b),segFN=segments_3,generation=3}
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@11ae29f9 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f2fde6b),segFN=segments_4,generation=4}
[junit4] 2> 2427157 T5625 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 4
[junit4] 2> 2427157 T5625 oasu.DefaultSolrCoreState.openIndexWriter New IndexWriter is ready to be used.
[junit4] 2> 2427160 T5625 oass.SolrIndexSearcher.<init> Opening Searcher@29bd07a6 main
[junit4] 2> 2427161 T5617 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@29bd07a6 main{StandardDirectoryReader(segments_4:7:nrt _0(4.5):c1 _1(4.5):c1 _2(4.5):c1)}
[junit4] 2> 2427161 T5625 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-1376282519145\slave\collection1\data\index.20130812144159587 [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-1376282519145\slave\collection1\data\index.20130812144159587;done=true>>]
[junit4] 2> 2427162 T5625 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-1376282519145\slave\collection1\data\index.20130812144159587
[junit4] 2> ASYNC NEW_CORE C5128 name=collection1 org.apache.solr.core.SolrCore@282f439b
[junit4] 2> 2427162 T5610 C5128 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={masterUrl=http://127.0.0.1:57204/solr/replication&command=fetchindex&wait=true} status=0 QTime=96
[junit4] 2> 2427189 T5594 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 2427193 T5594 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:57214
[junit4] 2> 2427193 T5594 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 2427194 T5594 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 2427194 T5594 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282519675\repeater
[junit4] 2> 2427194 T5594 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282519675\repeater\'
[junit4] 2> 2427216 T5594 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-1376282519675\repeater\solr.xml
[junit4] 2> 2427217 T5594 oasc.ConfigSolr.fromFile C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282519675\repeater\solr.xml does not exist, using default configuration
[junit4] 2> 2427276 T5594 oasc.CoreContainer.<init> New CoreContainer 853456332
[junit4] 2> 2427277 T5594 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282519675\repeater\]
[junit4] 2> 2427278 T5594 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 2427278 T5594 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 2427278 T5594 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 2427278 T5594 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 2427279 T5594 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 2427279 T5594 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 2427279 T5594 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 2427279 T5594 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 2427279 T5594 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 2427281 T5594 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 2427292 T5637 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282519675\repeater\collection1
[junit4] 2> 2427292 T5637 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282519675\repeater\collection1\'
[junit4] 2> 2427345 T5637 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_45
[junit4] 2> 2427401 T5637 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 2427401 T5637 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 2427407 T5637 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 2427442 T5637 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 2427444 T5637 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 2427445 T5637 oasc.SolrCore.<init> [collection1] Opening new SolrCore at .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282519675\repeater\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282519675\repeater\collection1\data\
[junit4] 2> 2427445 T5637 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 2427445 T5637 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-1376282519675\repeater\collection1\data\
[junit4] 2> 2427445 T5637 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-1376282519675\repeater\collection1\data\index/
[junit4] 2> 2427445 T5637 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-1376282519675\repeater\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 2427445 T5637 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-1376282519675\repeater\collection1\data\index
[junit4] 2> 2427446 T5637 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@51f43b12 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4780f067),segFN=segments_1,generation=1}
[junit4] 2> 2427446 T5637 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 2427448 T5637 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 2427448 T5637 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 2427448 T5637 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 2427448 T5637 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 2427449 T5637 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 2427449 T5637 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 2427450 T5637 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2427454 T5637 oass.SolrIndexSearcher.<init> Opening Searcher@1a9100af main
[junit4] 2> 2427455 T5637 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 2427455 T5637 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 2427455 T5637 oash.SnapPuller.<init> WARN 'masterUrl' must be specified without the /replication suffix
[junit4] 2> 2427455 T5637 oash.SnapPuller.<init> No value set for 'pollInterval'. Timer Task not started.
[junit4] 2> 2427455 T5637 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml
[junit4] 2> 2427456 T5637 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 2427456 T5637 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 2427456 T5638 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1a9100af main{StandardDirectoryReader(segments_1:1)}
[junit4] 2> 2427457 T5594 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 2427457 T5594 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 2427457 T5594 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> ASYNC NEW_CORE C5129 name=collection1 org.apache.solr.core.SolrCore@331d09e3
[junit4] 2> 2427470 T5600 C5129 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=indexversion&qt=/replication&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 2427470 T5599 C5129 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> 2427471 T5618 oash.SnapPuller.fetchLatestIndex Slave in sync with master.
[junit4] 2> ASYNC NEW_CORE C5130 name=collection1 org.apache.solr.core.SolrCore@776498ff
[junit4] 2> 2427471 T5630 C5130 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> 2427484 T5594 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=853456332
[junit4] 2> 2427486 T5594 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@776498ff
[junit4] 2> 2427486 T5594 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> 2427487 T5594 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 2427487 T5594 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 2427488 T5594 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 2427489 T5594 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 2427489 T5594 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 2427490 T5594 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-1376282519675\repeater\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-1376282519675\repeater\collection1\data\;done=false>>]
[junit4] 2> 2427490 T5594 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-1376282519675\repeater\collection1\data\
[junit4] 2> 2427490 T5594 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-1376282519675\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-1376282519675\repeater\collection1\data\index;done=false>>]
[junit4] 2> 2427491 T5594 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-1376282519675\repeater\collection1\data\index
[junit4] 2> 2427493 T5594 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 2427561 T5594 oas.SolrTestCaseJ4.tearDown ###Ending doTestDetails
[junit4] 2> 2427571 T5594 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1937434737
[junit4] 2> 2427573 T5594 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@331d09e3
[junit4] 2> 2427573 T5594 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=3,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=3,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 2427573 T5594 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 2427574 T5594 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 2427574 T5594 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 2427576 T5594 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 2427578 T5594 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 2427578 T5594 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-1376282518827\master\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-1376282518827\master\collection1\data\index;done=false>>]
[junit4] 2> 2427579 T5594 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-1376282518827\master\collection1\data\index
[junit4] 2> 2427579 T5594 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-1376282518827\master\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-1376282518827\master\collection1\data\;done=false>>]
[junit4] 2> 2427579 T5594 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-1376282518827\master\collection1\data\
[junit4] 2> 2427581 T5594 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 2427644 T5594 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=97874532
[junit4] 2> 2427645 T5594 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@282f439b
[junit4] 2> 2427646 T5594 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> 2427646 T5594 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 2427648 T5594 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 2427648 T5594 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 2427651 T5594 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 2427651 T5594 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 2427652 T5594 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-1376282519145\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-1376282519145\slave\collection1\data\index;done=false>>]
[junit4] 2> 2427654 T5594 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-1376282519145\slave\collection1\data\index
[junit4] 2> 2427655 T5594 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-1376282519145\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-1376282519145\slave\collection1\data\;done=false>>]
[junit4] 2> 2427655 T5594 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-1376282519145\slave\collection1\data\
[junit4] 2> 2427656 T5594 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 2427737 T5594 oas.SolrTestCaseJ4.setUp ###Starting doTestStressReplication
[junit4] 2> 2427749 T5594 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 2427752 T5594 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:57220
[junit4] 2> 2427752 T5594 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 2427752 T5594 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 2427752 T5594 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282520248\master
[junit4] 2> 2427752 T5594 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282520248\master\'
[junit4] 2> 2427776 T5594 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-1376282520248\master\solr.xml
[junit4] 2> 2427777 T5594 oasc.ConfigSolr.fromFile C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282520248\master\solr.xml does not exist, using default configuration
[junit4] 2> 2427837 T5594 oasc.CoreContainer.<init> New CoreContainer 270636498
[junit4] 2> 2427837 T5594 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282520248\master\]
[junit4] 2> 2427839 T5594 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 2427839 T5594 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 2427839 T5594 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 2427840 T5594 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 2427840 T5594 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 2427840 T5594 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 2427840 T5594 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 2427840 T5594 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 2427841 T5594 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 2427841 T5594 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 2427854 T5649 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282520248\master\collection1
[junit4] 2> 2427854 T5649 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282520248\master\collection1\'
[junit4] 2> 2427904 T5649 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_45
[junit4] 2> 2427965 T5649 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 2427966 T5649 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 2427971 T5649 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 2427991 T5649 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 2427991 T5649 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 2427991 T5649 oasc.SolrCore.<init> [collection1] Opening new SolrCore at .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282520248\master\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282520248\master\collection1\data\
[junit4] 2> 2427992 T5649 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 2427992 T5649 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-1376282520248\master\collection1\data\
[junit4] 2> 2427992 T5649 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-1376282520248\master\collection1\data\index/
[junit4] 2> 2427992 T5649 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-1376282520248\master\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 2427993 T5649 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-1376282520248\master\collection1\data\index
[junit4] 2> 2427994 T5649 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@75f7ae1e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7883c96c),segFN=segments_1,generation=1}
[junit4] 2> 2427994 T5649 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 2427995 T5649 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 2427995 T5649 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 2427995 T5649 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 2427995 T5649 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 2427995 T5649 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 2427996 T5649 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 2428001 T5649 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2428003 T5649 oass.SolrIndexSearcher.<init> Opening Searcher@1f18a994 main
[junit4] 2> 2428003 T5649 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 2428004 T5649 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 2428004 T5649 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 2428004 T5649 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 2428005 T5649 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 2428005 T5650 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1f18a994 main{StandardDirectoryReader(segments_1:1)}
[junit4] 2> 2428005 T5594 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 2428005 T5594 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 2428006 T5594 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> 2428024 T5594 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 2428027 T5594 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:57223
[junit4] 2> 2428027 T5594 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 2428027 T5594 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 2428028 T5594 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282520519\slave
[junit4] 2> 2428028 T5594 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282520519\slave\'
[junit4] 2> 2428040 T5594 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-1376282520519\slave\solr.xml
[junit4] 2> 2428041 T5594 oasc.ConfigSolr.fromFile C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282520519\slave\solr.xml does not exist, using default configuration
[junit4] 2> 2428094 T5594 oasc.CoreContainer.<init> New CoreContainer 1314754545
[junit4] 2> 2428095 T5594 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282520519\slave\]
[junit4] 2> 2428097 T5594 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 2428097 T5594 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 2428097 T5594 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 2428097 T5594 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 2428097 T5594 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 2428098 T5594 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 2428098 T5594 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 2428099 T5594 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 2428099 T5594 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 2428099 T5594 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 2428109 T5661 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282520519\slave\collection1
[junit4] 2> 2428109 T5661 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282520519\slave\collection1\'
[junit4] 2> 2428162 T5661 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_45
[junit4] 2> 2428228 T5661 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 2428229 T5661 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 2428234 T5661 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 2428253 T5661 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 2428256 T5661 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 2428257 T5661 oasc.SolrCore.<init> [collection1] Opening new SolrCore at .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282520519\slave\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282520519\slave\collection1\data\
[junit4] 2> 2428257 T5661 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 2428257 T5661 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-1376282520519\slave\collection1\data\
[junit4] 2> 2428257 T5661 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-1376282520519\slave\collection1\data\index/
[junit4] 2> 2428258 T5661 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-1376282520519\slave\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 2428258 T5661 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-1376282520519\slave\collection1\data\index
[junit4] 2> 2428260 T5661 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@391dcfd1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b74e5c6),segFN=segments_1,generation=1}
[junit4] 2> 2428260 T5661 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 2428262 T5661 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 2428262 T5661 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 2428262 T5661 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 2428262 T5661 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 2428263 T5661 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 2428264 T5661 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 2428266 T5661 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2428268 T5661 oass.SolrIndexSearcher.<init> Opening Searcher@6eeb6d9a main
[junit4] 2> 2428269 T5661 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 2428269 T5661 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 2428270 T5661 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
[junit4] 2> 2428270 T5661 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 2428270 T5662 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6eeb6d9a main{StandardDirectoryReader(segments_1:1)}
[junit4] 2> 2428270 T5594 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 2428270 T5594 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 2428271 T5594 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> 2428292 T5594 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1314754545
[junit4] 2> 2428294 T5594 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@5143ded8
[junit4] 2> 2428295 T5594 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> 2428295 T5594 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 2428295 T5594 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 2428297 T5594 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 2428298 T5594 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 2428298 T5594 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 2428299 T5594 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-1376282520519\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-1376282520519\slave\collection1\data\index;done=false>>]
[junit4] 2> 2428300 T5594 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-1376282520519\slave\collection1\data\index
[junit4] 2> 2428300 T5594 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-1376282520519\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-1376282520519\slave\collection1\data\;done=false>>]
[junit4] 2> 2428301 T5594 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-1376282520519\slave\collection1\data\
[junit4] 2> 2428303 T5594 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 2428355 T5594 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 2428360 T5594 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:57226
[junit4] 2> 2428362 T5594 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 2428363 T5594 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 2428364 T5594 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282520519\slave
[junit4] 2> 2428364 T5594 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282520519\slave\'
[junit4] 2> 2428387 T5594 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-1376282520519\slave\solr.xml
[junit4] 2> 2428388 T5594 oasc.ConfigSolr.fromFile C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282520519\slave\solr.xml does not exist, using default configuration
[junit4] 2> 2428439 T5594 oasc.CoreContainer.<init> New CoreContainer 1602198570
[junit4] 2> 2428440 T5594 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282520519\slave\]
[junit4] 2> 2428441 T5594 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 2428442 T5594 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 2428442 T5594 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 2428442 T5594 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 2428442 T5594 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 2428443 T5594 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 2428443 T5594 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 2428443 T5594 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 2428444 T5594 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 2428444 T5594 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 2428452 T5674 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282520519\slave\collection1
[junit4] 2> 2428452 T5674 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282520519\slave\collection1\'
[junit4] 2> 2428512 T5674 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_45
[junit4] 2> 2428571 T5674 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 2428571 T5674 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 2428577 T5674 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 2428594 T5674 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 2428595 T5674 oasc.SolrCore.initDirectoryFactory solr.StandardDirectoryFactory
[junit4] 2> 2428595 T5674 oasc.SolrCore.<init> [collection1] Opening new SolrCore at .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282520519\slave\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282520519\slave\collection1\data\
[junit4] 2> 2428596 T5674 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 2428596 T5674 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-1376282520519\slave\collection1\data
[junit4] 2> 2428597 T5674 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-1376282520519\slave\collection1\data\index/
[junit4] 2> 2428598 T5674 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-1376282520519\slave\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 2428598 T5674 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-1376282520519\slave\collection1\data\index
[junit4] 2> 2428609 T5674 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1376282520519\slave\collection1\data\index,segFN=segments_1,generation=1}
[junit4] 2> 2428609 T5674 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 2428611 T5674 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 2428611 T5674 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 2428611 T5674 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 2428612 T5674 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 2428612 T5674 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 2428613 T5674 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 2428615 T5674 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2428622 T5674 oass.SolrIndexSearcher.<init> Opening Searcher@2a13cda7 main
[junit4] 2> 2428623 T5674 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 2428623 T5674 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 2428624 T5674 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 2428625 T5674 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 2428625 T5675 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2a13cda7 main{StandardDirectoryReader(segments_1:1)}
[junit4] 2> 2428625 T5594 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 2428625 T5594 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 2428626 T5594 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 2> 2428643 T5594 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=270636498
[junit4] 2> 2428643 T5594 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@3439ae7d
[junit4] 2> 2428643 T5594 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> 2428643 T5594 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4]
[...truncated too long message...]
CLOSING SolrCore org.apache.solr.core.SolrCore@60a6e6e
[junit4] 2> 2480834 T5594 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> 2480835 T5594 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 2480835 T5594 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 2480836 T5594 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 2480840 T5594 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 2480841 T5594 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 2480841 T5594 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-1376282568711\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-1376282568711\slave\collection1\data\index;done=false>>]
[junit4] 2> 2480841 T5594 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-1376282568711\slave\collection1\data\index
[junit4] 2> 2480842 T5594 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-1376282568711\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-1376282568711\slave\collection1\data\;done=false>>]
[junit4] 2> 2480843 T5594 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-1376282568711\slave\collection1\data\
[junit4] 2> 2480844 T5594 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 2480901 T6283 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 2480901 T6283 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 2480910 T6283 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 2480976 T5594 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 54673 T5593 ccr.ThreadLeakControl.checkThreadLeaks WARNING Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> 2480999 T6283 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 2481001 T6283 oasc.CoreContainer.recordAndThrow ERROR Unable to reload core: collection1 java.lang.IllegalStateException: IndexWriter has been closed
[junit4] 2> at org.apache.solr.update.SolrCoreState.increfSolrCoreState(SolrCoreState.java:52)
[junit4] 2> at org.apache.solr.core.SolrCore.reload(SolrCore.java:406)
[junit4] 2> at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:675)
[junit4] 2> at org.apache.solr.handler.SnapPuller$2.run(SnapPuller.java:688)
[junit4] 2>
[junit4] 2> 2481002 T6283 oash.SnapPuller$2.run ERROR Could not reload core org.apache.solr.common.SolrException: Unable to reload core: collection1
[junit4] 2> at org.apache.solr.core.CoreContainer.recordAndThrow(CoreContainer.java:930)
[junit4] 2> at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:685)
[junit4] 2> at org.apache.solr.handler.SnapPuller$2.run(SnapPuller.java:688)
[junit4] 2> Caused by: java.lang.IllegalStateException: IndexWriter has been closed
[junit4] 2> at org.apache.solr.update.SolrCoreState.increfSolrCoreState(SolrCoreState.java:52)
[junit4] 2> at org.apache.solr.core.SolrCore.reload(SolrCore.java:406)
[junit4] 2> at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:675)
[junit4] 2> ... 1 more
[junit4] 2>
[junit4] 2> NOTE: test params are: codec=Lucene40, sim=DefaultSimilarity, locale=ca_ES, timezone=Australia/Melbourne
[junit4] 2> NOTE: Windows 7 6.1 amd64/Sun Microsystems Inc. 1.6.0_45 (64-bit)/cpus=2,threads=1,free=129381160,total=281227264
[junit4] 2> NOTE: All tests run in this JVM: [TestShardHandlerFactory, TestPartialUpdateDeduplication, StatsComponentTest, DateMathParserTest, TestIndexingPerformance, TestPerFieldSimilarity, CurrencyFieldOpenExchangeTest, HdfsChaosMonkeySafeLeaderTest, PathHierarchyTokenizerFactoryTest, TestDynamicFieldResource, SpellCheckComponentTest, TestDefaultSearchFieldResource, DebugComponentTest, ZkNodePropsTest, TestPseudoReturnFields, MoreLikeThisHandlerTest, PeerSyncTest, SuggesterWFSTTest, TestReloadAndDeleteDocs, FileUtilsTest, SoftAutoCommitTest, TermsComponentTest, TestComponentsName, CoreAdminCreateDiscoverTest, NotRequiredUniqueKeyTest, HighlighterConfigTest, TestCoreDiscovery, DocValuesMultiTest, IndexBasedSpellCheckerTest, TimeZoneUtilsTest, SpellingQueryConverterTest, DefaultValueUpdateProcessorTest, ChaosMonkeySafeLeaderTest, BasicDistributedZkTest, AddSchemaFieldsUpdateProcessorFactoryTest, DocValuesTest, SliceStateUpdateTest, TestLMJelinekMercerSimilarityFactory, BasicFunctionalityTest, LukeRequestHandlerTest, TestSolrXmlPersistence, TestCloudManagedSchemaAddField, BinaryUpdateRequestHandlerTest, TestRandomFaceting, UpdateRequestProcessorFactoryTest, DirectUpdateHandlerOptimizeTest, SolrInfoMBeanTest, XmlUpdateRequestHandlerTest, TestInfoStreamLogging, TestSweetSpotSimilarityFactory, TestDistributedGrouping, SystemInfoHandlerTest, EchoParamsTest, MultiTermTest, DistanceFunctionTest, TestBinaryField, CoreAdminHandlerTest, SuggesterFSTTest, TestRemoteStreaming, ConvertedLegacyTest, ShardRoutingTest, TestSolrXMLSerializer, TestFieldResource, CustomCollectionTest, TestTrie, TestSolrDeletionPolicy1, DistributedQueryElevationComponentTest, DistributedTermsComponentTest, NoCacheHeaderTest, TestFaceting, ChaosMonkeyNothingIsSafeTest, PolyFieldTest, TestRandomMergePolicy, TestSurroundQueryParser, UUIDFieldTest, SortByFunctionTest, TestGroupingSearch, HdfsLockFactoryTest, FileBasedSpellCheckerTest, BlockCacheTest, OverseerTest, RequestHandlersTest, SpellPossibilityIteratorTest, TestBinaryResponseWriter, TestReload, TestSuggestSpellingConverter, TestStressVersions, TestWordDelimiterFilterFactory, TestFieldCollectionResource, TestMaxScoreQueryParser, TestSchemaSimilarityResource, TermVectorComponentTest, TestManagedSchemaFieldResource, RecoveryZkTest, TestLuceneMatchVersion, SliceStateTest, ResponseLogComponentTest, TestOmitPositions, OverseerCollectionProcessorTest, SolrPluginUtilsTest, TestPhraseSuggestions, TestDistributedSearch, BadComponentTest, URLClassifyProcessorTest, RequiredFieldsTest, TestSolrCoreProperties, PrimitiveFieldTypeTest, TestQuerySenderNoQuery, SuggesterTSTTest, AlternateDirectoryTest, ParsingFieldUpdateProcessorsTest, ShardRoutingCustomTest, DeleteShardTest, TestRecovery, ResourceLoaderTest, StatelessScriptUpdateProcessorFactoryTest, BasicZkTest, TestHashPartitioner, BlockDirectoryTest, TestSearchPerf, SpatialFilterTest, TermVectorComponentDistributedTest, TestCopyFieldCollectionResource, TestDFRSimilarityFactory, UnloadDistributedZkTest, TestPHPSerializedResponseWriter, IndexSchemaTest, RegexBoostProcessorTest, TestStressRecovery, TestSolrQueryParserResource, SolrCoreTest, SolrRequestParserTest, TestFiltering, HdfsBasicDistributedZkTest, PreAnalyzedUpdateProcessorTest, SampleTest, CoreMergeIndexesAdminHandlerTest, TestJmxMonitoredMap, CacheHeaderTest, NumericFieldsTest, TestManagedSchema, PingRequestHandlerTest, InfoHandlerTest, TestFunctionQuery, TestSchemaNameResource, SynonymTokenizerTest, TestLMDirichletSimilarityFactory, HardAutoCommitTest, HighlighterTest, TestStressLucene, UniqFieldsUpdateProcessorFactoryTest, BasicDistributedZk2Test, CollectionsAPIDistributedZkTest, SyncSliceTest, OpenCloseCoreStressTest, LeaderElectionIntegrationTest, FullSolrCloudDistribCmdsTest, TestReplicationHandler]
[junit4] Completed in 54.98s, 14 tests, 1 failure <<< FAILURES!
[...truncated 473 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:449: 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: 319 suites, 1350 tests, 1 failure, 42 ignored (13 assumptions)
Total time: 84 minutes 5 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/jdk1.6.0_45 -XX:+UseCompressedOops -XX:+UseSerialGC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure