lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@thetaphi.de>
Subject [JENKINS] Lucene-Solr-4.x-Windows (64bit/jdk1.8.0-ea-b106) - Build # 3271 - Failure!
Date Fri, 11 Oct 2013 10:33:34 GMT
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Windows/3271/
Java: 64bit/jdk1.8.0-ea-b106 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC

1 tests failed.
REGRESSION:  org.apache.solr.handler.TestReplicationHandler.doTestStressReplication

Error Message:
timed out waiting for collection1 startAt time to exceed: Fri Oct 11 00:06:17 GMT-10:00 2013

Stack Trace:
java.lang.AssertionError: timed out waiting for collection1 startAt time to exceed: Fri Oct 11 00:06:17 GMT-10:00 2013
	at __randomizedtesting.SeedInfo.seed([433CD2FEFAD0A906:9897D238FFF8C0B5]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.apache.solr.handler.TestReplicationHandler.watchCoreStartAt(TestReplicationHandler.java:1514)
	at org.apache.solr.handler.TestReplicationHandler.doTestStressReplication(TestReplicationHandler.java:818)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:491)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
	at java.lang.Thread.run(Thread.java:724)




Build Log:
[...truncated 10076 lines...]
   [junit4] Suite: org.apache.solr.handler.TestReplicationHandler
   [junit4]   2> 408736 T1235 oas.SolrTestCaseJ4.setUp ###Starting testNoWriter
   [junit4]   2> 408755 T1235 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 408767 T1235 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:50796
   [junit4]   2> 408767 T1235 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
   [junit4]   2> 408767 T1235 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 408767 T1235 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944465\master
   [junit4]   2> 408767 T1235 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944465\master\'
   [junit4]   2> 408795 T1235 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-1381485944465\master\solr.xml
   [junit4]   2> 408875 T1235 oasc.CoreContainer.<init> New CoreContainer 1017622962
   [junit4]   2> 408875 T1235 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944465\master\]
   [junit4]   2> 408876 T1235 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 120000
   [junit4]   2> 408876 T1235 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
   [junit4]   2> 408876 T1235 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
   [junit4]   2> 408877 T1235 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 408877 T1235 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 408877 T1235 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 408877 T1235 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 408877 T1235 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 408878 T1235 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 408878 T1235 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=120000&connTimeout=15000&retry=false
   [junit4]   2> 408882 T1235 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 408883 T1235 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 408887 T1247 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944465\master\collection1
   [junit4]   2> 408887 T1247 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944465\master\collection1\'
   [junit4]   2> 408913 T1247 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_46
   [junit4]   2> 408927 T1247 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 408929 T1247 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 408933 T1247 oass.IndexSchema.readSchema [collection1] Schema name=test
   [junit4]   2> 408946 T1247 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 408947 T1247 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 408947 T1247 oasc.SolrCore.<init> [collection1] Opening new SolrCore at .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944465\master\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944465\master\collection1\data\
   [junit4]   2> 408947 T1247 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
   [junit4]   2> 408948 T1247 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-1381485944465\master\collection1\data\
   [junit4]   2> 408948 T1247 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-1381485944465\master\collection1\data\index/
   [junit4]   2> 408948 T1247 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-1381485944465\master\collection1\data\index' doesn't exist. Creating new index...
   [junit4]   2> 408948 T1247 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-1381485944465\master\collection1\data\index
   [junit4]   2> 408949 T1247 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=34, maxMergeAtOnceExplicit=15, maxMergedSegmentMB=40.9833984375, floorSegmentMB=0.681640625, forceMergeDeletesPctAllowed=19.98043920634556, segmentsPerTier=17.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 408949 T1247 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@24407d38 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@682a9adf),segFN=segments_1,generation=1}
   [junit4]   2> 408949 T1247 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 408950 T1247 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 408952 T1247 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 408952 T1247 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
   [junit4]   2> 408953 T1247 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
   [junit4]   2> 408953 T1247 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 408953 T1247 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
   [junit4]   2> 408953 T1247 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 408958 T1247 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 408959 T1247 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 408959 T1247 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 408960 T1247 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=16, maxMergeAtOnceExplicit=19, maxMergedSegmentMB=56.43359375, floorSegmentMB=1.0986328125, forceMergeDeletesPctAllowed=13.885452661399537, segmentsPerTier=12.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.10896531075579992
   [junit4]   2> 408960 T1247 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@24407d38 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@682a9adf),segFN=segments_1,generation=1}
   [junit4]   2> 408960 T1247 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 408961 T1247 oass.SolrIndexSearcher.<init> Opening Searcher@14789125 main
   [junit4]   2> 408961 T1247 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 408962 T1247 oash.ReplicationHandler.inform Commits will be reserved for  10000
   [junit4]   2> 408962 T1247 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 408963 T1235 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
   [junit4]   2> 408963 T1235 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 408964 T1235 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
   [junit4]   2> 408981 T1235 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 408987 T1235 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:50799
   [junit4]   2> 408990 T1235 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
   [junit4]   2> 408990 T1235 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 408992 T1235 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944693\slave
   [junit4]   2> 408992 T1235 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944693\slave\'
   [junit4]   2> 409008 T1235 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-1381485944693\slave\solr.xml
   [junit4]   2> 409025 T1248 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@14789125 main{StandardDirectoryReader(segments_1:1:nrt)}
   [junit4]   2> 409028 T1235 oasc.CoreContainer.<init> New CoreContainer 1725061992
   [junit4]   2> 409028 T1235 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944693\slave\]
   [junit4]   2> 409030 T1235 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 120000
   [junit4]   2> 409030 T1235 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
   [junit4]   2> 409030 T1235 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
   [junit4]   2> 409030 T1235 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 409032 T1235 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 409032 T1235 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 409032 T1235 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 409032 T1235 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 409032 T1235 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 409032 T1235 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=120000&connTimeout=15000&retry=false
   [junit4]   2> 409034 T1235 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 409035 T1235 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 409041 T1261 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944693\slave\collection1
   [junit4]   2> 409041 T1261 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944693\slave\collection1\'
   [junit4]   2> 409076 T1261 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_46
   [junit4]   2> 409084 T1261 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 409084 T1261 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 409095 T1261 oass.IndexSchema.readSchema [collection1] Schema name=test
   [junit4]   2> 409098 T1261 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 409098 T1261 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 409099 T1261 oasc.SolrCore.<init> [collection1] Opening new SolrCore at .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944693\slave\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944693\slave\collection1\data\
   [junit4]   2> 409099 T1261 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
   [junit4]   2> 409100 T1261 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-1381485944693\slave\collection1\data\
   [junit4]   2> 409100 T1261 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-1381485944693\slave\collection1\data\index/
   [junit4]   2> 409100 T1261 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-1381485944693\slave\collection1\data\index' doesn't exist. Creating new index...
   [junit4]   2> 409100 T1261 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-1381485944693\slave\collection1\data\index
   [junit4]   2> 409100 T1261 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=34, maxMergeAtOnceExplicit=15, maxMergedSegmentMB=40.9833984375, floorSegmentMB=0.681640625, forceMergeDeletesPctAllowed=19.98043920634556, segmentsPerTier=17.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 409101 T1261 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@15d610e3 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@81cba81),segFN=segments_1,generation=1}
   [junit4]   2> 409101 T1261 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 409103 T1261 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 409103 T1261 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 409103 T1261 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
   [junit4]   2> 409103 T1261 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 409103 T1261 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
   [junit4]   2> 409104 T1261 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 409104 T1261 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
   [junit4]   2> 409106 T1261 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 409106 T1261 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 409107 T1261 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 409107 T1261 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=16, maxMergeAtOnceExplicit=19, maxMergedSegmentMB=56.43359375, floorSegmentMB=1.0986328125, forceMergeDeletesPctAllowed=13.885452661399537, segmentsPerTier=12.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.10896531075579992
   [junit4]   2> 409107 T1261 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@15d610e3 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@81cba81),segFN=segments_1,generation=1}
   [junit4]   2> 409107 T1261 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 409108 T1261 oass.SolrIndexSearcher.<init> Opening Searcher@1ee91f13 main
   [junit4]   2> 409113 T1261 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
   [junit4]   2> 409113 T1261 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 409115 T1235 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
   [junit4]   2> 409115 T1235 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 409115 T1235 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
   [junit4]   2> 409123 T1262 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1ee91f13 main{StandardDirectoryReader(segments_1:1:nrt)}
   [junit4]   2> 409132 T1235 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1725061992
   [junit4]   2> 409134 T1235 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@abd3834
   [junit4]   2> 409134 T1235 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> 409135 T1235 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 409135 T1235 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 409135 T1235 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 409137 T1235 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 409137 T1235 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 409137 T1235 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-1381485944693\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-1381485944693\slave\collection1\data\index;done=false>>]
   [junit4]   2> 409137 T1235 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-1381485944693\slave\collection1\data\index
   [junit4]   2> 409138 T1235 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-1381485944693\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-1381485944693\slave\collection1\data\;done=false>>]
   [junit4]   2> 409139 T1235 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-1381485944693\slave\collection1\data\
   [junit4]   2> 409139 T1235 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 409537 T1235 oejut.QueuedThreadPool.doStop WARN 7 threads could not be stopped
   [junit4]   2> 409553 T1235 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1017622962
   [junit4]   2> 409553 T1235 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@3d095a9c
   [junit4]   2> 409553 T1235 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> 409553 T1235 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 409554 T1235 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 409554 T1235 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 409557 T1235 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 409557 T1235 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 409557 T1235 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-1381485944465\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-1381485944465\master\collection1\data\;done=false>>]
   [junit4]   2> 409557 T1235 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-1381485944465\master\collection1\data\
   [junit4]   2> 409558 T1235 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-1381485944465\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-1381485944465\master\collection1\data\index;done=false>>]
   [junit4]   2> 409558 T1235 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-1381485944465\master\collection1\data\index
   [junit4]   2> 409558 T1235 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 409613 T1235 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 409617 T1235 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:50799
   [junit4]   2> 409617 T1235 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
   [junit4]   2> 409618 T1235 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 409618 T1235 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944693\slave
   [junit4]   2> 409618 T1235 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944693\slave\'
   [junit4]   2> 409635 T1235 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-1381485944693\slave\solr.xml
   [junit4]   2> 409654 T1235 oasc.CoreContainer.<init> New CoreContainer 910009061
   [junit4]   2> 409654 T1235 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944693\slave\]
   [junit4]   2> 409655 T1235 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 120000
   [junit4]   2> 409655 T1235 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
   [junit4]   2> 409656 T1235 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
   [junit4]   2> 409656 T1235 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 409656 T1235 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 409656 T1235 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 409656 T1235 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 409657 T1235 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 409657 T1235 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 409657 T1235 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=120000&connTimeout=15000&retry=false
   [junit4]   2> 409658 T1235 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 409659 T1235 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 409666 T1276 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944693\slave\collection1
   [junit4]   2> 409666 T1276 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944693\slave\collection1\'
   [junit4]   2> 409707 T1276 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_46
   [junit4]   2> 409721 T1276 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 409722 T1276 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 409725 T1276 oass.IndexSchema.readSchema [collection1] Schema name=test
   [junit4]   2> 409728 T1276 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 409730 T1276 oasc.SolrCore.initDirectoryFactory solr.NRTCachingDirectoryFactory
   [junit4]   2> 409730 T1276 oasc.SolrCore.<init> [collection1] Opening new SolrCore at .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944693\slave\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944693\slave\collection1\data\
   [junit4]   2> 409730 T1276 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
   [junit4]   2> 409731 T1276 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-1381485944693\slave\collection1\data
   [junit4]   2> 409732 T1276 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-1381485944693\slave\collection1\data\index/
   [junit4]   2> 409732 T1276 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-1381485944693\slave\collection1\data\index' doesn't exist. Creating new index...
   [junit4]   2> 409733 T1276 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-1381485944693\slave\collection1\data\index
   [junit4]   2> 409733 T1276 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=24, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
   [junit4]   2> 409738 T1276 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=NRTCachingDirectory(org.apache.lucene.store.MMapDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944693\slave\collection1\data\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@303120d4; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
   [junit4]   2> 409738 T1276 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 409739 T1276 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 409739 T1276 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 409739 T1276 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
   [junit4]   2> 409739 T1276 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 409739 T1276 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
   [junit4]   2> 409741 T1276 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 409741 T1276 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
   [junit4]   2> 409748 T1276 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 409750 T1276 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 409750 T1276 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 409752 T1276 oass.SolrIndexSearcher.<init> Opening Searcher@7f6c85e6 main
   [junit4]   2> 409753 T1276 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
   [junit4]   2> 409753 T1276 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 409753 T1277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7f6c85e6 main{StandardDirectoryReader(segments_1:1)}
   [junit4]   2> 409754 T1235 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
   [junit4]   2> 409754 T1235 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 409755 T1235 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 409759 T1235 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:50796
   [junit4]   2> 409759 T1235 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
   [junit4]   2> 409767 T1235 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 409767 T1235 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944465\master
   [junit4]   2> 409767 T1235 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944465\master\'
   [junit4]   2> 409798 T1235 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-1381485944465\master\solr.xml
   [junit4]   2> 409822 T1235 oasc.CoreContainer.<init> New CoreContainer 694759551
   [junit4]   2> 409823 T1235 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944465\master\]
   [junit4]   2> 409823 T1235 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 120000
   [junit4]   2> 409823 T1235 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
   [junit4]   2> 409823 T1235 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
   [junit4]   2> 409824 T1235 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 409824 T1235 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 409824 T1235 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 409825 T1235 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 409825 T1235 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 409826 T1235 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 409826 T1235 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=120000&connTimeout=15000&retry=false
   [junit4]   2> 409831 T1235 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 409831 T1235 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 409834 T1289 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944465\master\collection1
   [junit4]   2> 409835 T1289 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944465\master\collection1\'
   [junit4]   2> 409867 T1289 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_46
   [junit4]   2> 409884 T1289 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 409885 T1289 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 409889 T1289 oass.IndexSchema.readSchema [collection1] Schema name=test
   [junit4]   2> 409895 T1289 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 409895 T1289 oasc.SolrCore.initDirectoryFactory solr.NRTCachingDirectoryFactory
   [junit4]   2> 409897 T1289 oasc.SolrCore.<init> [collection1] Opening new SolrCore at .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944465\master\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944465\master\collection1\data\
   [junit4]   2> 409897 T1289 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
   [junit4]   2> 409897 T1289 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-1381485944465\master\collection1\data
   [junit4]   2> 409898 T1289 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-1381485944465\master\collection1\data\index/
   [junit4]   2> 409898 T1289 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-1381485944465\master\collection1\data\index' doesn't exist. Creating new index...
   [junit4]   2> 409899 T1289 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-1381485944465\master\collection1\data\index
   [junit4]   2> 409900 T1289 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=24, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
   [junit4]   2> 409904 T1289 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=NRTCachingDirectory(org.apache.lucene.store.MMapDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944465\master\collection1\data\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3229482a; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
   [junit4]   2> 409905 T1289 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 409906 T1289 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 409906 T1289 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 409907 T1289 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
   [junit4]   2> 409907 T1289 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
   [junit4]   2> 409907 T1289 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 409907 T1289 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
   [junit4]   2> 409907 T1289 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 409915 T1289 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 409917 T1289 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 409917 T1289 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 409920 T1289 oass.SolrIndexSearcher.<init> Opening Searcher@4878c4c7 main
   [junit4]   2> 409920 T1289 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 409920 T1289 oash.ReplicationHandler.inform Commits will be reserved for  10000
   [junit4]   2> 409920 T1289 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 409921 T1290 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4878c4c7 main{StandardDirectoryReader(segments_1:1)}
   [junit4]   2> 409921 T1235 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
   [junit4]   2> 409922 T1235 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> ASYNC  NEW_CORE C2023 name=collection1 org.apache.solr.core.SolrCore@6a458edb
   [junit4]   2> 409929 T1270 C2023 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=24, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
   [junit4]   2> 409932 T1270 C2023 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=NRTCachingDirectory(org.apache.lucene.store.MMapDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944693\slave\collection1\data\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@303120d4; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
   [junit4]   2> 409934 T1270 C2023 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 409935 T1270 C2023 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[123456]} 0 10
   [junit4]   2> 409941 T1275 C2023 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 409964 T1275 C2023 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=NRTCachingDirectory(org.apache.lucene.store.MMapDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944693\slave\collection1\data\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@303120d4; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
   [junit4]   2> 		commit{dir=NRTCachingDirectory(org.apache.lucene.store.MMapDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944693\slave\collection1\data\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@303120d4; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_2,generation=2}
   [junit4]   2> 409964 T1275 C2023 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
   [junit4]   2> 409980 T1275 C2023 oass.SolrIndexSearcher.<init> Opening Searcher@76412160 main
   [junit4]   2> 409981 T1275 C2023 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 409981 T1277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@76412160 main{StandardDirectoryReader(segments_2:3 _0(4.6):c1)}
   [junit4]   2> 409981 T1275 C2023 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 40
   [junit4]   2> 409996 T1235 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=910009061
   [junit4]   2> 409998 T1235 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@6a458edb
   [junit4]   2> 409999 T1235 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> 410000 T1235 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 410000 T1235 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 410001 T1235 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 410003 T1235 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 410004 T1235 oasc.CachingDirectoryFactory.close Closing NRTCachingDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 410004 T1235 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-1381485944693\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-1381485944693\slave\collection1\data\index;done=false>>]
   [junit4]   2> 410004 T1235 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-1381485944693\slave\collection1\data\index
   [junit4]   2> 410005 T1235 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-1381485944693\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-1381485944693\slave\collection1\data;done=false>>]
   [junit4]   2> 410005 T1235 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-1381485944693\slave\collection1\data
   [junit4]   2> 410005 T1235 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 410061 T1235 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 410065 T1235 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:50799
   [junit4]   2> 410067 T1235 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
   [junit4]   2> 410069 T1235 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 410069 T1235 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944693\slave
   [junit4]   2> 410069 T1235 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944693\slave\'
   [junit4]   2> 410111 T1235 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-1381485944693\slave\solr.xml
   [junit4]   2> 410125 T1235 oasc.CoreContainer.<init> New CoreContainer 1875470216
   [junit4]   2> 410125 T1235 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944693\slave\]
   [junit4]   2> 410126 T1235 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 120000
   [junit4]   2> 410126 T1235 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
   [junit4]   2> 410126 T1235 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
   [junit4]   2> 410126 T1235 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 410126 T1235 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 410127 T1235 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 410127 T1235 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 410129 T1235 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 410129 T1235 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 410129 T1235 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=120000&connTimeout=15000&retry=false
   [junit4]   2> 410134 T1235 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 410134 T1235 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 410145 T1303 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944693\slave\collection1
   [junit4]   2> 410145 T1303 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944693\slave\collection1\'
   [junit4]   2> 410172 T1303 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_46
   [junit4]   2> 410186 T1303 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 410189 T1303 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 410192 T1303 oass.IndexSchema.readSchema [collection1] Schema name=test
   [junit4]   2> 410197 T1303 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 410197 T1303 oasc.SolrCore.initDirectoryFactory solr.NRTCachingDirectoryFactory
   [junit4]   2> 410199 T1303 oasc.SolrCore.<init> [collection1] Opening new SolrCore at .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944693\slave\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485944693\slave\collection1\data\
   [junit4]   2> 410199 T1303 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
   [junit4]   2> 410199 T1303 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-1381485944693\slave\collection1\data
   [junit4]   2> 410200 T1303 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-1381485944693\slave\collection1\data\index/
   [junit4]   2> 410201 T1303 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 410201 T1303 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 410202 T1303 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
   [junit4]   2> 410202 T1303 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 410202 T1303 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
   [junit4]   2> 410202 T1303 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 410202 T1303 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
   [junit4]   2> 410209 T1303 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 410213 T1303 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 410213 T1303 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 410213 T1303 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-1381485944693\slave\collection1\data\index
   [junit4]   2> 410216 T1303 oass.SolrIndexSearcher.<init> Opening Searcher@21b524b3 main
   [junit4]   2> 410217 T1303 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
   [junit4]   2> 410217 T1303 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 410218 T1304 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@21b524b3 main{StandardDirectoryReader(segments_2:3 _0(4.6):c1)}
   [junit4]   2> 410219 T1235 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
   [junit4]   2> 410219 T1235 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 410241 T1307 oash.SnapPuller.<init> WARN 'masterUrl' must be specified without the /replication suffix
   [junit4]   2> 410241 T1307 oash.SnapPuller.<init>  No value set for 'pollInterval'. Timer Task not started.
   [junit4]   2> ASYNC  NEW_CORE C2024 name=collection1 org.apache.solr.core.SolrCore@58123db6
   [junit4]   2> 410244 T1285 C2024 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=indexversion&qt=/replication&wt=javabin&version=2} status=0 QTime=1 
   [junit4]   2> ASYNC  NEW_CORE C2025 name=collection1 org.apache.solr.core.SolrCore@3b025d6b
   [junit4]   2> 410245 T1300 C2025 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={masterUrl=http://127.0.0.1:50796/solr/replication&command=fetchindex&wait=true} status=0 QTime=14 
   [junit4]   2> 410248 T1235 oas.SolrTestCaseJ4.tearDown ###Ending testNoWriter
   [junit4]   2> 410262 T1235 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=694759551
   [junit4]   2> 410263 T1235 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@58123db6
   [junit4]   2> 410263 T1235 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> 410264 T1235 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 410264 T1235 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 410264 T1235 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 410265 T1235 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 410266 T1235 oasc.CachingDirectoryFactory.close Closing NRTCachingDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 410266 T1235 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-1381485944465\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-1381485944465\master\collection1\data\index;done=false>>]
   [junit4]   2> 410266 T1235 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-1381485944465\master\collection1\data\index
   [junit4]   2> 410268 T1235 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-1381485944465\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-1381485944465\master\collection1\data;done=false>>]
   [junit4]   2> 410268 T1235 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-1381485944465\master\collection1\data
   [junit4]   2> 410268 T1235 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 410411 T1235 oejut.QueuedThreadPool.doStop WARN 7 threads could not be stopped
   [junit4]   2> 410425 T1235 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1875470216
   [junit4]   2> 410425 T1235 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@3b025d6b
   [junit4]   2> 411355 T1305 oash.SnapPuller.fetchLatestIndex ERROR Master at: http://127.0.0.1:50796/solr is not available. Index fetch failed. Exception: org.apache.solr.client.solrj.SolrServerException: Server refused connection at: http://127.0.0.1:50796/solr
   [junit4]   2> 411358 T1235 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> 411359 T1235 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 411359 T1235 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 411359 T1235 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 411366 T1235 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 411367 T1235 oasc.CachingDirectoryFactory.close Closing NRTCachingDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 411367 T1235 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-1381485944693\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-1381485944693\slave\collection1\data;done=false>>]
   [junit4]   2> 411368 T1235 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-1381485944693\slave\collection1\data
   [junit4]   2> 411368 T1235 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-1381485944693\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-1381485944693\slave\collection1\data\index;done=false>>]
   [junit4]   2> 411368 T1235 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-1381485944693\slave\collection1\data\index
   [junit4]   2> 411368 T1235 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 411687 T1235 oejut.QueuedThreadPool.doStop WARN 6 threads could not be stopped
   [junit4]   2> 411745 T1235 oas.SolrTestCaseJ4.setUp ###Starting doTestReplicateAfterCoreReload
   [junit4]   2> 411764 T1235 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 411774 T1235 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:50812
   [junit4]   2> 411774 T1235 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
   [junit4]   2> 411775 T1235 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 411775 T1235 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485947473\master
   [junit4]   2> 411775 T1235 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485947473\master\'
   [junit4]   2> 411807 T1235 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-1381485947473\master\solr.xml
   [junit4]   2> 411830 T1235 oasc.CoreContainer.<init> New CoreContainer 2087080738
   [junit4]   2> 411831 T1235 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485947473\master\]
   [junit4]   2> 411832 T1235 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 120000
   [junit4]   2> 411832 T1235 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
   [junit4]   2> 411832 T1235 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
   [junit4]   2> 411832 T1235 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 411832 T1235 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 411832 T1235 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 411833 T1235 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 411833 T1235 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 411833 T1235 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 411834 T1235 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=120000&connTimeout=15000&retry=false
   [junit4]   2> 411838 T1235 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 411838 T1235 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 411851 T1318 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485947473\master\collection1
   [junit4]   2> 411851 T1318 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485947473\master\collection1\'
   [junit4]   2> 411884 T1318 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_46
   [junit4]   2> 411893 T1318 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 411894 T1318 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 411904 T1318 oass.IndexSchema.readSchema [collection1] Schema name=test
   [junit4]   2> 411909 T1318 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 411910 T1318 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 411911 T1318 oasc.SolrCore.<init> [collection1] Opening new SolrCore at .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485947473\master\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485947473\master\collection1\data\
   [junit4]   2> 411911 T1318 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
   [junit4]   2> 411911 T1318 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-1381485947473\master\collection1\data\
   [junit4]   2> 411911 T1318 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-1381485947473\master\collection1\data\index/
   [junit4]   2> 411911 T1318 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-1381485947473\master\collection1\data\index' doesn't exist. Creating new index...
   [junit4]   2> 411912 T1318 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-1381485947473\master\collection1\data\index
   [junit4]   2> 411912 T1318 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=34, maxMergeAtOnceExplicit=15, maxMergedSegmentMB=40.9833984375, floorSegmentMB=0.681640625, forceMergeDeletesPctAllowed=19.98043920634556, segmentsPerTier=17.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 411912 T1318 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1a2227f7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@56bc62cc),segFN=segments_1,generation=1}
   [junit4]   2> 411912 T1318 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 411914 T1318 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 411914 T1318 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 411914 T1318 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
   [junit4]   2> 411915 T1318 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
   [junit4]   2> 411915 T1318 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 411915 T1318 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
   [junit4]   2> 411915 T1318 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 411920 T1318 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 411923 T1318 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 411923 T1318 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 411926 T1318 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=16, maxMergeAtOnceExplicit=19, maxMergedSegmentMB=56.43359375, floorSegmentMB=1.0986328125, forceMergeDeletesPctAllowed=13.885452661399537, segmentsPerTier=12.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.10896531075579992
   [junit4]   2> 411928 T1318 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1a2227f7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@56bc62cc),segFN=segments_1,generation=1}
   [junit4]   2> 411928 T1318 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 411928 T1318 oass.SolrIndexSearcher.<init> Opening Searcher@37fb40bf main
   [junit4]   2> 411928 T1318 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 411928 T1318 oash.ReplicationHandler.inform Commits will be reserved for  10000
   [junit4]   2> 411929 T1319 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@37fb40bf main{StandardDirectoryReader(segments_1:1:nrt)}
   [junit4]   2> 411929 T1318 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 411929 T1235 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
   [junit4]   2> 411929 T1235 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 411929 T1235 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
   [junit4]   2> 411953 T1235 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 411964 T1235 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:50815
   [junit4]   2> 411964 T1235 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
   [junit4]   2> 411964 T1235 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 411964 T1235 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485947659\slave
   [junit4]   2> 411964 T1235 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485947659\slave\'
   [junit4]   2> 411981 T1235 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-1381485947659\slave\solr.xml
   [junit4]   2> 412000 T1235 oasc.CoreContainer.<init> New CoreContainer 389452178
   [junit4]   2> 412001 T1235 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485947659\slave\]
   [junit4]   2> 412003 T1235 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 120000
   [junit4]   2> 412003 T1235 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
   [junit4]   2> 412003 T1235 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
   [junit4]   2> 412004 T1235 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 412004 T1235 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 412004 T1235 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 412004 T1235 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 412005 T1235 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 412005 T1235 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 412005 T1235 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=120000&connTimeout=15000&retry=false
   [junit4]   2> 412006 T1235 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 412007 T1235 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 412010 T1330 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485947659\slave\collection1
   [junit4]   2> 412010 T1330 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485947659\slave\collection1\'
   [junit4]   2> 412040 T1330 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_46
   [junit4]   2> 412055 T1330 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 412056 T1330 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 412059 T1330 oass.IndexSchema.readSchema [collection1] Schema name=test
   [junit4]   2> 412063 T1330 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 412063 T1330 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 412064 T1330 oasc.SolrCore.<init> [collection1] Opening new SolrCore at .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485947659\slave\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485947659\slave\collection1\data\
   [junit4]   2> 412064 T1330 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
   [junit4]   2> 412064 T1330 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-1381485947659\slave\collection1\data\
   [junit4]   2> 412064 T1330 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-1381485947659\slave\collection1\data\index/
   [junit4]   2> 412064 T1330 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-1381485947659\slave\collection1\data\index' doesn't exist. Creating new index...
   [junit4]   2> 412065 T1330 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-1381485947659\slave\collection1\data\index
   [junit4]   2> 412066 T1330 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=34, maxMergeAtOnceExplicit=15, maxMergedSegmentMB=40.9833984375, floorSegmentMB=0.681640625, forceMergeDeletesPctAllowed=19.98043920634556, segmentsPerTier=17.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 412066 T1330 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@64ba23d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f8bd021),segFN=segments_1,generation=1}
   [junit4]   2> 412066 T1330 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 412073 T1330 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 412074 T1330 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 412074 T1330 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
   [junit4]   2> 412074 T1330 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 412074 T1330 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
   [junit4]   2> 412074 T1330 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 412075 T1330 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
   [junit4]   2> 412076 T1330 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 412078 T1330 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 412078 T1330 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 412078 T1330 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=16, maxMergeAtOnceExplicit=19, maxMergedSegmentMB=56.43359375, floorSegmentMB=1.0986328125, forceMergeDeletesPctAllowed=13.885452661399537, segmentsPerTier=12.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.10896531075579992
   [junit4]   2> 412079 T1330 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@64ba23d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6f8bd021),segFN=segments_1,generation=1}
   [junit4]   2> 412079 T1330 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 412079 T1330 oass.SolrIndexSearcher.<init> Opening Searcher@15f80da6 main
   [junit4]   2> 412080 T1330 oash.SnapPuller.startExecutorService Poll Scheduled at an interval of 1000ms
   [junit4]   2> 412080 T1330 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 412080 T1331 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@15f80da6 main{StandardDirectoryReader(segments_1:1:nrt)}
   [junit4]   2> 412081 T1235 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
   [junit4]   2> 412081 T1235 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 412083 T1235 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
   [junit4]   2> 412099 T1235 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=389452178
   [junit4]   2> 412100 T1235 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@149605ca
   [junit4]   2> 412101 T1235 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> 412101 T1235 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 412101 T1235 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 412101 T1235 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 412105 T1235 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 412106 T1235 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 412106 T1235 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-1381485947659\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-1381485947659\slave\collection1\data\index;done=false>>]
   [junit4]   2> 412107 T1235 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-1381485947659\slave\collection1\data\index
   [junit4]   2> 412107 T1235 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-1381485947659\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-1381485947659\slave\collection1\data\;done=false>>]
   [junit4]   2> 412107 T1235 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-1381485947659\slave\collection1\data\
   [junit4]   2> 412108 T1235 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 413846 T1235 oejut.QueuedThreadPool.doStop WARN 6 threads could not be stopped
   [junit4]   2> 413872 T1235 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=2087080738
   [junit4]   2> 413873 T1235 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@432cc631
   [junit4]   2> 413873 T1235 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> 413873 T1235 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 413873 T1235 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 413874 T1235 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 413878 T1235 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 413878 T1235 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 413878 T1235 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-1381485947473\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-1381485947473\master\collection1\data\;done=false>>]
   [junit4]   2> 413879 T1235 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-1381485947473\master\collection1\data\
   [junit4]   2> 413879 T1235 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-1381485947473\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-1381485947473\master\collection1\data\index;done=false>>]
   [junit4]   2> 413880 T1235 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-1381485947473\master\collection1\data\index
   [junit4]   2> 413880 T1235 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 415728 T1235 oejut.QueuedThreadPool.doStop WARN 8 threads could not be stopped
   [junit4]   2> 415730 T1235 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 415736 T1235 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:50818
   [junit4]   2> 415736 T1235 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
   [junit4]   2> 415737 T1235 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 415737 T1235 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485947473\master
   [junit4]   2> 415737 T1235 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485947473\master\'
   [junit4]   2> 415755 T1235 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-1381485947473\master\solr.xml
   [junit4]   2> 415777 T1235 oasc.CoreContainer.<init> New CoreContainer 2140703592
   [junit4]   2> 415777 T1235 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1381485947473\master\]
   [junit4]   2> 415778 T1235 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 120000
   [junit4]   2> 415778 T1235 oashc.HttpShardHandl

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

/solr path=/replication params={command=indexversion&_trace=assertVersions&wt=javabin&qt=/replication&version=2} status=0 QTime=0 
   [junit4]   2> 487503 T1935 C2109 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={slave=false&command=details&wt=javabin&qt=/replication&version=2} status=0 QTime=1 
   [junit4]   2> 487504 T1914 C2108 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=details&_trace=getDetails&wt=javabin&qt=/replication&version=2} status=0 QTime=4 
   [junit4]   2> 487510 T1915 C2108 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={slave=false&command=details&wt=javabin&qt=/replication&version=2} status=0 QTime=2 
   [junit4]   2> 487511 T1942 C2109 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={command=details&_trace=getDetails&wt=javabin&qt=/replication&version=2} status=0 QTime=4 
   [junit4]   2> 487512 T1235 oas.SolrTestCaseJ4.tearDown ###Ending doTestSnapPullWithMasterUrl
   [junit4]   2> 487522 T1235 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1161699436
   [junit4]   2> 487526 T1235 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@201cca73
   [junit4]   2> 487526 T1235 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=2,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=496,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
   [junit4]   2> 487526 T1235 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 487526 T1235 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 487526 T1235 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 487527 T1235 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 487528 T1235 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 487528 T1235 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-1381486021197\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-1381486021197\master\collection1\data\;done=false>>]
   [junit4]   2> 487528 T1235 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-1381486021197\master\collection1\data\
   [junit4]   2> 487528 T1235 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-1381486021197\master\collection1\data\index.20131011000703085 [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-1381486021197\master\collection1\data\index.20131011000703085;done=false>>]
   [junit4]   2> 487528 T1235 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-1381486021197\master\collection1\data\index.20131011000703085
   [junit4]   2> 487529 T1235 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 487594 T1235 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=776418267
   [junit4]   2> 487596 T1235 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@23f54ba5
   [junit4]   2> 487596 T1235 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=2,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=3,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
   [junit4]   2> 487597 T1235 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 487597 T1235 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 487597 T1235 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 487601 T1235 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 487601 T1235 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 487602 T1235 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-1381486021336\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-1381486021336\slave\collection1\data\;done=false>>]
   [junit4]   2> 487602 T1235 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-1381486021336\slave\collection1\data\
   [junit4]   2> 487602 T1235 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-1381486021336\slave\collection1\data\index.20131011000702843 [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-1381486021336\slave\collection1\data\index.20131011000702843;done=false>>]
   [junit4]   2> 487602 T1235 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-1381486021336\slave\collection1\data\index.20131011000702843
   [junit4]   2> 487602 T1235 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 487687 T1235 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> NOTE: test params are: codec=Lucene45: {newname=MockVariableIntBlock(baseBlockSize=112), id=MockVariableIntBlock(baseBlockSize=112), name=MockVariableIntBlock(baseBlockSize=112)}, docValues:{}, sim=DefaultSimilarity, locale=ar_YE, timezone=Etc/GMT+10
   [junit4]   2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0-ea (64-bit)/cpus=2,threads=1,free=33690280,total=111419392
   [junit4]   2> NOTE: All tests run in this JVM: [SliceStateUpdateTest, TestFastWriter, HdfsSyncSliceTest, TestSolrDeletionPolicy2, RequestHandlersTest, TestFiltering, OverseerCollectionProcessorTest, BasicZkTest, PrimUtilsTest, ReturnFieldsTest, BinaryUpdateRequestHandlerTest, TestShardHandlerFactory, DistributedSpellCheckComponentTest, RecoveryZkTest, OutputWriterTest, CircularListTest, TestCodecSupport, TestJmxMonitoredMap, NumericFieldsTest, MultiTermTest, TestDefaultSimilarityFactory, TestJoin, SliceStateTest, StatsComponentTest, TestReloadAndDeleteDocs, TestCSVResponseWriter, MoreLikeThisHandlerTest, TestXIncludeConfig, TestNonNRTOpen, BadCopyFieldTest, TestCopyFieldCollectionResource, UUIDFieldTest, XsltUpdateRequestHandlerTest, SolrCmdDistributorTest, SyncSliceTest, CoreAdminHandlerTest, TestSolrCoreProperties, AssignTest, CurrencyFieldOpenExchangeTest, TestTrie, LegacyHTMLStripCharFilterTest, EchoParamsTest, CurrencyFieldXmlFileTest, TestHashPartitioner, TestElisionMultitermQuery, SolrIndexSplitterTest, DebugComponentTest, TestManagedSchema, TestSchemaSimilarityResource, SignatureUpdateProcessorFactoryTest, TestSolrQueryParserResource, TestRandomDVFaceting, TestManagedSchemaFieldResource, TestRecoveryHdfs, SolrCoreTest, TestFieldCollectionResource, TestCollationField, TestFunctionQuery, TestRealTimeGet, SearchHandlerTest, TestReplicationHandler]
   [junit4] Completed in 78.98s, 14 tests, 1 failure <<< FAILURES!

[...truncated 823 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:428: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:408: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:39: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build.xml:189: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\common-build.xml:451: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\lucene\common-build.xml:1233: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\lucene\common-build.xml:876: There were test failures: 327 suites, 1453 tests, 1 failure, 43 ignored (11 assumptions)

Total time: 59 minutes 24 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/jdk1.8.0-ea-b106 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure



Mime
View raw message