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 2014/01/26 16:53:24 UTC
[JENKINS] Lucene-Solr-4.x-Windows (32bit/jdk1.7.0_60-ea-b03) -
Build # 3638 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Windows/3638/
Java: 32bit/jdk1.7.0_60-ea-b03 -client -XX:+UseConcMarkSweepGC
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">12.05 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-1390749217806\master\collection1\data\index/</str><arr name="commits"><lst><long name="indexVersion">1390749219990</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">1390749219990</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">1390749219990</long><long name="replicableGeneration">2</long></lst><lst name="backup"><str name="startTime">Mon Jan 27 01:13:40 EST 2014</str><int name="fileCount">4</int><str name="status">success</str><str name="snapshotCompletedAt">Mon Jan 27 01:13:40 EST 2014</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">12.05 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-1390749217806\master\collection1\data\index/</str><arr name="commits"><lst><long name="indexVersion">1390749219990</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">1390749219990</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">1390749219990</long><long name="replicableGeneration">2</long></lst><lst name="backup"><str name="startTime">Mon Jan 27 01:13:40 EST 2014</str><int name="fileCount">4</int><str name="status">success</str><str name="snapshotCompletedAt">Mon Jan 27 01:13:40 EST 2014</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([1A723F782B90235D:5BF91F1D0C2ED012]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.apache.solr.handler.TestReplicationHandler.doTestBackup(TestReplicationHandler.java:1403)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java: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:744)
Build Log:
[...truncated 10275 lines...]
[junit4] Suite: org.apache.solr.handler.TestReplicationHandler
[junit4] 2> 945302 T2913 oas.SolrTestCaseJ4.setUp ###Starting testNoWriter
[junit4] 2> 945325 T2913 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 945335 T2913 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:59064
[junit4] 2> 945336 T2913 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 945336 T2913 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 945336 T2913 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208741\master
[junit4] 2> 945336 T2913 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208741\master\'
[junit4] 2> 945365 T2913 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-1390749208741\master\solr.xml
[junit4] 2> 945418 T2913 oasc.CoreContainer.<init> New CoreContainer 24347366
[junit4] 2> 945418 T2913 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208741\master\]
[junit4] 2> 945420 T2913 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 945420 T2913 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 945420 T2913 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 945420 T2913 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 945420 T2913 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 945420 T2913 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 945420 T2913 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 945420 T2913 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 945420 T2913 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 945426 T2913 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 945426 T2913 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 945427 T2913 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 945433 T2923 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208741\master\collection1
[junit4] 2> 945434 T2923 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208741\master\collection1\'
[junit4] 2> 945479 T2923 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 945516 T2923 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 945516 T2923 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 945523 T2923 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 945536 T2923 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 945537 T2923 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 945538 T2923 oasc.SolrCore.<init> [collection1] Opening new SolrCore at .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208741\master\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208741\master\collection1\data\
[junit4] 2> 945538 T2923 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 945538 T2923 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-1390749208741\master\collection1\data\
[junit4] 2> 945538 T2923 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-1390749208741\master\collection1\data\index/
[junit4] 2> 945538 T2923 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-1390749208741\master\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 945539 T2923 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-1390749208741\master\collection1\data\index
[junit4] 2> 945539 T2923 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=29, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 945540 T2923 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@15725f6 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@54b401),segFN=segments_1,generation=1}
[junit4] 2> 945540 T2923 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 945542 T2923 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 945543 T2923 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 945543 T2923 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 945543 T2923 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 945543 T2923 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 945543 T2923 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 945543 T2923 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 945552 T2923 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 945554 T2923 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 945555 T2923 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 945555 T2923 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=12, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.3473762005966859]
[junit4] 2> 945555 T2923 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@15725f6 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@54b401),segFN=segments_1,generation=1}
[junit4] 2> 945555 T2923 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 945555 T2923 oass.SolrIndexSearcher.<init> Opening Searcher@af7464 main
[junit4] 2> 945556 T2923 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 945556 T2923 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 945556 T2923 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 945556 T2924 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@af7464 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 945557 T2913 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 945557 T2913 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 945572 T2913 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 945581 T2913 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:59067
[junit4] 2> 945582 T2913 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 945582 T2913 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 945582 T2913 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208996\slave
[junit4] 2> 945582 T2913 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208996\slave\'
[junit4] 2> 945597 T2913 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-1390749208996\slave\solr.xml
[junit4] 2> 945636 T2913 oasc.CoreContainer.<init> New CoreContainer 1494081
[junit4] 2> 945636 T2913 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208996\slave\]
[junit4] 2> 945637 T2913 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 945637 T2913 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 945637 T2913 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 945637 T2913 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 945637 T2913 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 945637 T2913 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 945637 T2913 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 945639 T2913 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 945639 T2913 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 945642 T2913 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 945642 T2913 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 945642 T2913 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 945648 T2935 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208996\slave\collection1
[junit4] 2> 945649 T2935 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208996\slave\collection1\'
[junit4] 2> 945697 T2935 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 945732 T2935 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 945733 T2935 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 945738 T2935 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 945749 T2935 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 945750 T2935 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 945750 T2935 oasc.SolrCore.<init> [collection1] Opening new SolrCore at .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208996\slave\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208996\slave\collection1\data\
[junit4] 2> 945751 T2935 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 945751 T2935 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-1390749208996\slave\collection1\data\
[junit4] 2> 945751 T2935 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-1390749208996\slave\collection1\data\index/
[junit4] 2> 945752 T2935 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-1390749208996\slave\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 945752 T2935 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-1390749208996\slave\collection1\data\index
[junit4] 2> 945753 T2935 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=29, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 945753 T2935 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ec95c7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4eeb7c),segFN=segments_1,generation=1}
[junit4] 2> 945754 T2935 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 945755 T2935 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 945755 T2935 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 945755 T2935 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 945755 T2935 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 945755 T2935 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 945756 T2935 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 945756 T2935 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 945757 T2935 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 945760 T2935 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 945760 T2935 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 945760 T2935 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=12, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.3473762005966859]
[junit4] 2> 945761 T2935 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ec95c7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4eeb7c),segFN=segments_1,generation=1}
[junit4] 2> 945761 T2935 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 945761 T2935 oass.SolrIndexSearcher.<init> Opening Searcher@1f182ae main
[junit4] 2> 945765 T2935 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
[junit4] 2> 945766 T2935 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 945766 T2936 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1f182ae main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 945767 T2913 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 945767 T2913 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 945778 T2913 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1494081
[junit4] 2> 945779 T2913 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@fda737
[junit4] 2> 945780 T2913 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> 945781 T2913 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 945781 T2913 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 945781 T2913 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 945783 T2913 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 945783 T2913 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 945783 T2913 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-1390749208996\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-1390749208996\slave\collection1\data\;done=false>>]
[junit4] 2> 945783 T2913 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-1390749208996\slave\collection1\data\
[junit4] 2> 945783 T2913 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-1390749208996\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-1390749208996\slave\collection1\data\index;done=false>>]
[junit4] 2> 945783 T2913 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-1390749208996\slave\collection1\data\index
[junit4] 2> 945787 T2913 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 945852 T2913 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=24347366
[junit4] 2> 945853 T2913 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@17a7182
[junit4] 2> 945853 T2913 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> 945853 T2913 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 945853 T2913 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 945853 T2913 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 945857 T2913 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 945857 T2913 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 945857 T2913 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-1390749208741\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-1390749208741\master\collection1\data\;done=false>>]
[junit4] 2> 945857 T2913 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-1390749208741\master\collection1\data\
[junit4] 2> 945857 T2913 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-1390749208741\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-1390749208741\master\collection1\data\index;done=false>>]
[junit4] 2> 945857 T2913 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-1390749208741\master\collection1\data\index
[junit4] 2> 945857 T2913 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 945910 T2913 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 945918 T2913 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:59067
[junit4] 2> 945919 T2913 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 945919 T2913 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 945919 T2913 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208996\slave
[junit4] 2> 945921 T2913 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208996\slave\'
[junit4] 2> 945944 T2913 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-1390749208996\slave\solr.xml
[junit4] 2> 945987 T2913 oasc.CoreContainer.<init> New CoreContainer 21502413
[junit4] 2> 945987 T2913 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208996\slave\]
[junit4] 2> 945989 T2913 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 945989 T2913 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 945989 T2913 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 945989 T2913 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 945989 T2913 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 945989 T2913 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 945991 T2913 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 945991 T2913 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 945991 T2913 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 945993 T2913 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 945993 T2913 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 945993 T2913 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 945998 T2948 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208996\slave\collection1
[junit4] 2> 946000 T2948 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208996\slave\collection1\'
[junit4] 2> 946046 T2948 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 946082 T2948 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 946082 T2948 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 946088 T2948 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 946101 T2948 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 946101 T2948 oasc.SolrCore.initDirectoryFactory solr.NRTCachingDirectoryFactory
[junit4] 2> 946124 T2948 oasc.SolrCore.<init> [collection1] Opening new SolrCore at .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208996\slave\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208996\slave\collection1\data\
[junit4] 2> 946124 T2948 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 946124 T2948 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-1390749208996\slave\collection1\data
[junit4] 2> 946124 T2948 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-1390749208996\slave\collection1\data\index/
[junit4] 2> 946124 T2948 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-1390749208996\slave\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 946126 T2948 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-1390749208996\slave\collection1\data\index
[junit4] 2> 946127 T2948 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=46, maxMergeAtOnceExplicit=40, maxMergedSegmentMB=71.9345703125, floorSegmentMB=1.5458984375, forceMergeDeletesPctAllowed=6.754663822387811, segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 946134 T2948 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=NRTCachingDirectory(org.apache.lucene.store.SimpleFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208996\slave\collection1\data\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@81a8a1; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> 946134 T2948 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 946136 T2948 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 946136 T2948 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 946136 T2948 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 946136 T2948 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 946136 T2948 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 946137 T2948 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 946137 T2948 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 946144 T2948 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 946150 T2948 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 946150 T2948 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 946152 T2948 oass.SolrIndexSearcher.<init> Opening Searcher@4bd613 main
[junit4] 2> 946153 T2948 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
[junit4] 2> 946153 T2948 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 946153 T2949 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4bd613 main{StandardDirectoryReader(segments_1:1)}
[junit4] 2> 946154 T2913 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 946154 T2913 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 946155 T2913 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 946161 T2913 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:59064
[junit4] 2> 946161 T2913 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 946162 T2913 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 946162 T2913 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208741\master
[junit4] 2> 946162 T2913 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208741\master\'
[junit4] 2> 946188 T2913 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-1390749208741\master\solr.xml
[junit4] 2> 946239 T2913 oasc.CoreContainer.<init> New CoreContainer 28174273
[junit4] 2> 946240 T2913 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208741\master\]
[junit4] 2> 946241 T2913 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 946241 T2913 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 946242 T2913 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 946242 T2913 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 946242 T2913 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 946243 T2913 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 946243 T2913 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 946243 T2913 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 946244 T2913 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 946248 T2913 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 946248 T2913 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 946248 T2913 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 946253 T2961 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208741\master\collection1
[junit4] 2> 946254 T2961 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208741\master\collection1\'
[junit4] 2> 946300 T2961 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 946349 T2961 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 946349 T2961 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 946355 T2961 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 946371 T2961 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 946372 T2961 oasc.SolrCore.initDirectoryFactory solr.NRTCachingDirectoryFactory
[junit4] 2> 946372 T2961 oasc.SolrCore.<init> [collection1] Opening new SolrCore at .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208741\master\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208741\master\collection1\data\
[junit4] 2> 946372 T2961 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 946372 T2961 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-1390749208741\master\collection1\data
[junit4] 2> 946374 T2961 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-1390749208741\master\collection1\data\index/
[junit4] 2> 946374 T2961 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-1390749208741\master\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 946376 T2961 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-1390749208741\master\collection1\data\index
[junit4] 2> 946376 T2961 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=46, maxMergeAtOnceExplicit=40, maxMergedSegmentMB=71.9345703125, floorSegmentMB=1.5458984375, forceMergeDeletesPctAllowed=6.754663822387811, segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 946383 T2961 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=NRTCachingDirectory(org.apache.lucene.store.SimpleFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208741\master\collection1\data\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@43d71e; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> 946384 T2961 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 946384 T2961 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 946385 T2961 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 946385 T2961 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 946385 T2961 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 946386 T2961 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 946386 T2961 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 946386 T2961 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 946396 T2961 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 946400 T2961 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 946400 T2961 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 946402 T2961 oass.SolrIndexSearcher.<init> Opening Searcher@13e3951 main
[junit4] 2> 946403 T2961 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 946403 T2961 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 946403 T2961 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 946403 T2962 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@13e3951 main{StandardDirectoryReader(segments_1:1)}
[junit4] 2> 946404 T2913 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 946404 T2913 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> ASYNC NEW_CORE C4609 name=collection1 org.apache.solr.core.SolrCore@17ba070
[junit4] 2> 946410 T2944 C4609 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=46, maxMergeAtOnceExplicit=40, maxMergedSegmentMB=71.9345703125, floorSegmentMB=1.5458984375, forceMergeDeletesPctAllowed=6.754663822387811, segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 946413 T2944 C4609 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=NRTCachingDirectory(org.apache.lucene.store.SimpleFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208996\slave\collection1\data\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@81a8a1; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> 946414 T2944 C4609 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 946415 T2944 C4609 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[123456]} 0 7
[junit4] 2> 946418 T2943 C4609 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 946440 T2943 C4609 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=NRTCachingDirectory(org.apache.lucene.store.SimpleFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208996\slave\collection1\data\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@81a8a1; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=NRTCachingDirectory(org.apache.lucene.store.SimpleFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208996\slave\collection1\data\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@81a8a1; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_2,generation=2}
[junit4] 2> 946441 T2943 C4609 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 946457 T2943 C4609 oass.SolrIndexSearcher.<init> Opening Searcher@8f6053 main
[junit4] 2> 946458 T2943 C4609 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 946458 T2949 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@8f6053 main{StandardDirectoryReader(segments_2:3 _0(4.7):c1)}
[junit4] 2> 946458 T2943 C4609 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={version=2&waitSearcher=true&softCommit=false&wt=javabin&commit=true} {commit=} 0 40
[junit4] 2> 946471 T2913 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=21502413
[junit4] 2> 946473 T2913 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@17ba070
[junit4] 2> 946475 T2913 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=1,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 946475 T2913 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 946475 T2913 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 946475 T2913 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 946479 T2913 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 946479 T2913 oasc.CachingDirectoryFactory.close Closing NRTCachingDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 946480 T2913 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-1390749208996\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-1390749208996\slave\collection1\data;done=false>>]
[junit4] 2> 946481 T2913 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-1390749208996\slave\collection1\data
[junit4] 2> 946481 T2913 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-1390749208996\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-1390749208996\slave\collection1\data\index;done=false>>]
[junit4] 2> 946481 T2913 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-1390749208996\slave\collection1\data\index
[junit4] 2> 946483 T2913 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 946535 T2913 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 946545 T2913 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:59067
[junit4] 2> 946547 T2913 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 946547 T2913 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 946547 T2913 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208996\slave
[junit4] 2> 946549 T2913 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208996\slave\'
[junit4] 2> 946580 T2913 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-1390749208996\slave\solr.xml
[junit4] 2> 946631 T2913 oasc.CoreContainer.<init> New CoreContainer 11164362
[junit4] 2> 946632 T2913 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208996\slave\]
[junit4] 2> 946632 T2913 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 946632 T2913 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 946633 T2913 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 946633 T2913 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 946633 T2913 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 946634 T2913 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 946634 T2913 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 946634 T2913 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 946635 T2913 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 946640 T2913 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 946640 T2913 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 946640 T2913 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 946645 T2973 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208996\slave\collection1
[junit4] 2> 946646 T2973 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208996\slave\collection1\'
[junit4] 2> 946687 T2973 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 946722 T2973 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 946723 T2973 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 946729 T2973 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 946753 T2973 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 946754 T2973 oasc.SolrCore.initDirectoryFactory solr.NRTCachingDirectoryFactory
[junit4] 2> 946755 T2973 oasc.SolrCore.<init> [collection1] Opening new SolrCore at .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208996\slave\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749208996\slave\collection1\data\
[junit4] 2> 946755 T2973 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 946755 T2973 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-1390749208996\slave\collection1\data
[junit4] 2> 946755 T2973 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-1390749208996\slave\collection1\data\index/
[junit4] 2> 946757 T2973 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 946757 T2973 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 946758 T2973 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 946758 T2973 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 946758 T2973 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 946758 T2973 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 946758 T2973 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 946764 T2973 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 946768 T2973 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 946768 T2973 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 946768 T2973 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-1390749208996\slave\collection1\data\index
[junit4] 2> 946770 T2973 oass.SolrIndexSearcher.<init> Opening Searcher@634885 main
[junit4] 2> 946771 T2973 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
[junit4] 2> 946772 T2973 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 946772 T2974 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@634885 main{StandardDirectoryReader(segments_2:3 _0(4.7):c1)}
[junit4] 2> 946772 T2913 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 946772 T2913 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 946790 T2977 oash.SnapPuller.<init> WARN 'masterUrl' must be specified without the /replication suffix
[junit4] 2> 946791 T2977 oash.SnapPuller.<init> No value set for 'pollInterval'. Timer Task not started.
[junit4] 2> ASYNC NEW_CORE C4610 name=collection1 org.apache.solr.core.SolrCore@ac8eff
[junit4] 2> 946795 T2956 C4610 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={version=2&qt=/replication&command=indexversion&wt=javabin} status=0 QTime=0
[junit4] 2> ASYNC NEW_CORE C4611 name=collection1 org.apache.solr.core.SolrCore@ced728
[junit4] 2> 946796 T2967 C4611 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=fetchindex&masterUrl=http://127.0.0.1:59064/solr/replication&wait=true} status=0 QTime=21
[junit4] 2> 946799 T2913 oas.SolrTestCaseJ4.tearDown ###Ending testNoWriter
[junit4] 2> 946810 T2913 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=28174273
[junit4] 2> 946813 T2913 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@ac8eff
[junit4] 2> 946813 T2913 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> 946815 T2913 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 946815 T2913 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 946815 T2913 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 946818 T2913 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 946818 T2913 oasc.CachingDirectoryFactory.close Closing NRTCachingDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 946819 T2913 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-1390749208741\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-1390749208741\master\collection1\data;done=false>>]
[junit4] 2> 946820 T2913 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-1390749208741\master\collection1\data
[junit4] 2> 946821 T2913 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-1390749208741\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-1390749208741\master\collection1\data\index;done=false>>]
[junit4] 2> 946822 T2913 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-1390749208741\master\collection1\data\index
[junit4] 2> 946822 T2913 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 946889 T2913 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=11164362
[junit4] 2> 946892 T2913 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@ced728
[junit4] 2> 946892 T2913 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> 946893 T2913 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 946894 T2913 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 946895 T2913 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 946896 T2913 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 946897 T2913 oasc.CachingDirectoryFactory.close Closing NRTCachingDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 946898 T2913 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-1390749208996\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-1390749208996\slave\collection1\data\index;done=false>>]
[junit4] 2> 946899 T2913 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-1390749208996\slave\collection1\data\index
[junit4] 2> 946900 T2913 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-1390749208996\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-1390749208996\slave\collection1\data;done=false>>]
[junit4] 2> 946900 T2913 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-1390749208996\slave\collection1\data
[junit4] 2> 946901 T2913 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 947016 T2913 oas.SolrTestCaseJ4.setUp ###Starting doTestStressReplication
[junit4] 2> 947035 T2913 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 947039 T2913 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:59079
[junit4] 2> 947039 T2913 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 947040 T2913 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 947040 T2913 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749210454\master
[junit4] 2> 947040 T2913 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749210454\master\'
[junit4] 2> 947065 T2913 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-1390749210454\master\solr.xml
[junit4] 2> 947112 T2913 oasc.CoreContainer.<init> New CoreContainer 9637106
[junit4] 2> 947112 T2913 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749210454\master\]
[junit4] 2> 947114 T2913 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 947114 T2913 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 947114 T2913 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 947114 T2913 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 947114 T2913 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 947114 T2913 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 947114 T2913 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 947114 T2913 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 947114 T2913 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 947120 T2913 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 947120 T2913 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 947120 T2913 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 947125 T2988 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749210454\master\collection1
[junit4] 2> 947126 T2988 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749210454\master\collection1\'
[junit4] 2> 947172 T2988 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 947215 T2988 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 947215 T2988 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 947223 T2988 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 947237 T2988 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 947237 T2988 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 947238 T2988 oasc.SolrCore.<init> [collection1] Opening new SolrCore at .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749210454\master\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749210454\master\collection1\data\
[junit4] 2> 947238 T2988 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 947239 T2988 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-1390749210454\master\collection1\data\
[junit4] 2> 947239 T2988 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-1390749210454\master\collection1\data\index/
[junit4] 2> 947239 T2988 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-1390749210454\master\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 947240 T2988 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-1390749210454\master\collection1\data\index
[junit4] 2> 947240 T2988 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=29, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 947241 T2988 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1682131 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ca9c9c),segFN=segments_1,generation=1}
[junit4] 2> 947241 T2988 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 947242 T2988 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 947243 T2988 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 947244 T2988 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 947244 T2988 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 947244 T2988 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 947244 T2988 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 947244 T2988 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 947252 T2988 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 947255 T2988 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 947256 T2988 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 947256 T2988 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=12, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.3473762005966859]
[junit4] 2> 947256 T2988 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1682131 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ca9c9c),segFN=segments_1,generation=1}
[junit4] 2> 947256 T2988 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 947256 T2988 oass.SolrIndexSearcher.<init> Opening Searcher@1204805 main
[junit4] 2> 947257 T2988 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 947257 T2988 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 947257 T2988 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 947257 T2989 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1204805 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 947258 T2913 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 947259 T2913 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 947272 T2913 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 947279 T2913 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:59082
[junit4] 2> 947281 T2913 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 947281 T2913 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 947281 T2913 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749210697\slave
[junit4] 2> 947282 T2913 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749210697\slave\'
[junit4] 2> 947299 T2913 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-1390749210697\slave\solr.xml
[junit4] 2> 947346 T2913 oasc.CoreContainer.<init> New CoreContainer 8850979
[junit4] 2> 947346 T2913 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749210697\slave\]
[junit4] 2> 947348 T2913 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 947348 T2913 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 947349 T2913 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 947349 T2913 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 947349 T2913 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 947349 T2913 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 947349 T2913 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 947349 T2913 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 947350 T2913 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 947357 T2913 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 947357 T2913 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 947357 T2913 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 947363 T3000 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749210697\slave\collection1
[junit4] 2> 947364 T3000 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749210697\slave\collection1\'
[junit4] 2> 947410 T3000 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 947447 T3000 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 947447 T3000 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 947454 T3000 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 947465 T3000 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 947468 T3000 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 947468 T3000 oasc.SolrCore.<init> [collection1] Opening new SolrCore at .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749210697\slave\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749210697\slave\collection1\data\
[junit4] 2> 947468 T3000 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 947469 T3000 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-1390749210697\slave\collection1\data\
[junit4] 2> 947469 T3000 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-1390749210697\slave\collection1\data\index/
[junit4] 2> 947469 T3000 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-1390749210697\slave\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 947471 T3000 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-1390749210697\slave\collection1\data\index
[junit4] 2> 947472 T3000 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=29, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 947472 T3000 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@15533b6 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1b83cc7),segFN=segments_1,generation=1}
[junit4] 2> 947472 T3000 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 947474 T3000 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 947475 T3000 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 947475 T3000 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 947475 T3000 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 947475 T3000 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 947476 T3000 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 947476 T3000 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 947478 T3000 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 947481 T3000 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 947481 T3000 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 947481 T3000 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=12, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.3473762005966859]
[junit4] 2> 947481 T3000 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@15533b6 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1b83cc7),segFN=segments_1,generation=1}
[junit4] 2> 947481 T3000 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 947481 T3000 oass.SolrIndexSearcher.<init> Opening Searcher@f86e3d main
[junit4] 2> 947483 T3000 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
[junit4] 2> 947483 T3000 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 947483 T3001 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@f86e3d main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 947484 T2913 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 947485 T2913 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 947498 T2913 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=8850979
[junit4] 2> 947499 T2913 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1b56744
[junit4] 2> 947500 T2913 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> 947500 T2913 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 947500 T2913 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 947500 T2913 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 947501 T2913 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 947502 T2913 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 947503 T2913 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-1390749210697\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-1390749210697\slave\collection1\data\;done=false>>]
[junit4] 2> 947503 T2913 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-1390749210697\slave\collection1\data\
[junit4] 2> 947504 T2913 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-1390749210697\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-1390749210697\slave\collection1\data\index;done=false>>]
[junit4] 2> 947504 T2913 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-1390749210697\slave\collection1\data\index
[junit4] 2> 947504 T2913 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 947558 T2913 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 947562 T2913 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:59085
[junit4] 2> 947563 T2913 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 947564 T2913 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 947564 T2913 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749210697\slave
[junit4] 2> 947564 T2913 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749210697\slave\'
[junit4] 2> 947582 T2913 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-1390749210697\slave\solr.xml
[junit4] 2> 947624 T2913 oasc.CoreContainer.<init> New CoreContainer 5048330
[junit4] 2> 947624 T2913 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749210697\slave\]
[junit4] 2> 947626 T2913 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 947626 T2913 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 947626 T2913 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 947626 T2913 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 947626 T2913 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 947626 T2913 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 947626 T2913 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 947626 T2913 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 947628 T2913 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 947632 T2913 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 947632 T2913 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 947634 T2913 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 947638 T3013 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749210697\slave\collection1
[junit4] 2> 947639 T3013 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749210697\slave\collection1\'
[junit4] 2> 947681 T3013 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 947729 T3013 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 947729 T3013 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 947736 T3013 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 947748 T3013 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 947748 T3013 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 947749 T3013 oasc.SolrCore.<init> [collection1] Opening new SolrCore at .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749210697\slave\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1390749210697\slave\collection1\data\
[junit4] 2> 947749 T3013 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 947749 T3013 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr
[...truncated too long message...]
oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={version=2&qt=/replication&command=details&_trace=getDetails&wt=javabin} status=0 QTime=4
[junit4] 2> 990171 T3575 C4667 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={version=2&qt=/replication&command=indexversion&_trace=assertVersions&wt=javabin} status=0 QTime=0
[junit4] 2> 990174 T3588 C4668 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={version=2&qt=/replication&command=indexversion&_trace=assertVersions&wt=javabin} status=0 QTime=0
[junit4] 2> 990175 T2913 oas.SolrTestCaseJ4.tearDown ###Ending testEmptyCommits
[junit4] 2> 990186 T2913 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=21843271
[junit4] 2> 990189 T2913 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@4abd78
[junit4] 2> 990189 T2913 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=5,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=4,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 990189 T2913 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 990189 T2913 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 990189 T2913 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 990192 T2913 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 990192 T2913 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 990192 T2913 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-1390749252743\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-1390749252743\master\collection1\data\index;done=false>>]
[junit4] 2> 990192 T2913 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-1390749252743\master\collection1\data\index
[junit4] 2> 990194 T2913 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-1390749252743\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-1390749252743\master\collection1\data\;done=false>>]
[junit4] 2> 990194 T2913 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-1390749252743\master\collection1\data\
[junit4] 2> 990195 T2913 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 990260 T2913 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=16013728
[junit4] 2> 990261 T2913 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@489a61
[junit4] 2> 990262 T2913 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> 990263 T2913 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 990263 T2913 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 990263 T2913 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 990265 T2913 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 990265 T2913 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 990265 T2913 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-1390749253062\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-1390749253062\slave\collection1\data\;done=false>>]
[junit4] 2> 990265 T2913 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-1390749253062\slave\collection1\data\
[junit4] 2> 990265 T2913 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-1390749253062\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-1390749253062\slave\collection1\data\index;done=false>>]
[junit4] 2> 990265 T2913 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-1390749253062\slave\collection1\data\index
[junit4] 2> 990268 T2913 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 990356 T2913 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: test params are: codec=Lucene42, sim=DefaultSimilarity, locale=lt, timezone=Australia/Queensland
[junit4] 2> NOTE: Windows 7 6.1 x86/Oracle Corporation 1.7.0_60-ea (32-bit)/cpus=2,threads=1,free=324309504,total=455184384
[junit4] 2> NOTE: All tests run in this JVM: [ResourceLoaderTest, TestCollapseQParserPlugin, TestRealTimeGet, SolrPluginUtilsTest, TestRecovery, FieldAnalysisRequestHandlerTest, TestSuggestSpellingConverter, InfoHandlerTest, SpatialFilterTest, RecoveryZkTest, TestDynamicFieldResource, TestConfig, TestRTGBase, TestNoOpRegenerator, TestTrie, ZkCLITest, TestSchemaSimilarityResource, SuggesterFSTTest, URLClassifyProcessorTest, TestCustomSort, TestXIncludeConfig, WordBreakSolrSpellCheckerTest, TestSchemaVersionResource, BasicDistributedZk2Test, TermVectorComponentTest, DateMathParserTest, TestPHPSerializedResponseWriter, SampleTest, SuggesterTest, BasicDistributedZkTest, QueryEqualityTest, TestFastOutputStream, TestZkChroot, TestStressRecovery, DOMUtilTest, TestFiltering, CustomCollectionTest, BadIndexSchemaTest, TestMergePolicyConfig, SolrIndexSplitterTest, PolyFieldTest, MinimalSchemaTest, PluginInfoTest, UpdateRequestProcessorFactoryTest, TestBadConfig, CurrencyFieldXmlFileTest, ShardSplitTest, TestOverriddenPrefixQueryForCustomFieldType, TestRemoteStreaming, FileUtilsTest, AddSchemaFieldsUpdateProcessorFactoryTest, CollectionsAPIDistributedZkTest, TestHighFrequencyDictionaryFactory, PingRequestHandlerTest, SortByFunctionTest, RequestHandlersTest, TestFileDictionaryLookup, TestJoin, TestMultiCoreConfBootstrap, TestStressLucene, TestDocBasedVersionConstraints, SystemInfoHandlerTest, TestDocSet, ShowFileRequestHandlerTest, CursorPagingTest, TestIBSimilarityFactory, HdfsBasicDistributedZkTest, TestDynamicFieldCollectionResource, HighlighterConfigTest, TestFieldCollectionResource, DocValuesMissingTest, MoreLikeThisHandlerTest, SliceStateUpdateTest, StatelessScriptUpdateProcessorFactoryTest, TestNumberUtils, TestArbitraryIndexDir, TestWriterPerf, CacheHeaderTest, TestNRTOpen, DistanceFunctionTest, TestIndexSearcher, TestReplicationHandler]
[junit4] Completed in 45.09s, 14 tests, 1 failure <<< FAILURES!
[...truncated 853 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:459: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:439: 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\extra-targets.xml:37: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build.xml:189: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\common-build.xml:491: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\lucene\common-build.xml:1308: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\lucene\common-build.xml:941: There were test failures: 355 suites, 1548 tests, 1 failure, 40 ignored (12 assumptions)
Total time: 81 minutes 20 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 32bit/jdk1.7.0_60-ea-b03 -client -XX:+UseConcMarkSweepGC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure