You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2015/09/18 02:49:30 UTC
[JENKINS] Lucene-Solr-trunk-Windows (64bit/jdk1.8.0_60) - Build #
5264 - Still Failing!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/5264/
Java: 64bit/jdk1.8.0_60 -XX:+UseCompressedOops -XX:+UseConcMarkSweepGC
1 tests failed.
FAILED: org.apache.solr.handler.TestReplicationHandler.doTestStressReplication
Error Message:
[index.20150918032623807, index.20150918032637427, index.properties, replication.properties] expected:<1> but was:<2>
Stack Trace:
java.lang.AssertionError: [index.20150918032623807, index.20150918032637427, index.properties, replication.properties] expected:<1> but was:<2>
at __randomizedtesting.SeedInfo.seed([6927A5540FFC0008:B28CA5920AD469BB]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.apache.solr.handler.TestReplicationHandler.checkForSingleIndex(TestReplicationHandler.java:818)
at org.apache.solr.handler.TestReplicationHandler.doTestStressReplication(TestReplicationHandler.java:785)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:497)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
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:365)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
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 com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
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:365)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 10016 lines...]
[junit4] Suite: org.apache.solr.handler.TestReplicationHandler
[junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\init-core-data-001
[junit4] 2> 1610077 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.SolrTestCaseJ4 ###Starting doTestDetails
[junit4] 2> 1610077 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-001\collection1
[junit4] 2> 1610085 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.e.j.s.Server jetty-9.2.13.v20150730
[junit4] 2> 1610086 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4a8ef0a5{/solr,null,AVAILABLE}
[junit4] 2> 1610087 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.e.j.s.ServerConnector Started ServerConnector@6018a2da{HTTP/1.1}{127.0.0.1:49611}
[junit4] 2> 1610087 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.e.j.s.Server Started @1614364ms
[junit4] 2> 1610087 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-001\collection1\data, hostContext=/solr, hostPort=49611}
[junit4] 2> 1610087 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a
[junit4] 2> 1610088 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-001\'
[junit4] 2> 1610110 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-001\solr.xml
[junit4] 2> 1610115 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-001\.
[junit4] 2> 1610115 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.CoreContainer New CoreContainer 635448081
[junit4] 2> 1610116 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-001\]
[junit4] 2> 1610116 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.CoreContainer loading shared library: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-001\lib
[junit4] 2> 1610116 WARN (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-001\lib).
[junit4] 2> 1610122 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
[junit4] 2> 1610124 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1610125 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1610125 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1610125 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 1610125 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 1610127 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.CoresLocator Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-001\.
[junit4] 2> 1610129 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-001\.\collection1, absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-001\.\collection1\, dataDir=data\}
[junit4] 2> 1610129 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.CoresLocator Found core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-001\.\collection1\
[junit4] 2> 1610130 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.CoresLocator Found 1 core definitions
[junit4] 2> 1610131 INFO (coreLoadExecutor-4719-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-001\.\collection1\'
[junit4] 2> 1610131 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.s.SolrDispatchFilter user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1
[junit4] 2> 1610131 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 1610147 INFO (coreLoadExecutor-4719-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 1610149 INFO (coreLoadExecutor-4719-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 1610154 INFO (coreLoadExecutor-4719-thread-1) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1610154 INFO (coreLoadExecutor-4719-thread-1) [ ] o.a.s.s.IndexSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-001\.\collection1\conf\schema.xml
[junit4] 2> 1610156 INFO (coreLoadExecutor-4719-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1610159 INFO (coreLoadExecutor-4719-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 1610162 INFO (coreLoadExecutor-4719-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-001\.\collection1\conf'
[junit4] 2> 1610162 INFO (coreLoadExecutor-4719-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-001\.\collection1\
[junit4] 2> 1610163 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1610163 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-001\.\collection1\], dataDir=[null]
[junit4] 2> 1610163 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
[junit4] 2> 1610163 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-001\.\collection1\data\
[junit4] 2> 1610163 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-001\.\collection1\data\index/
[junit4] 2> 1610163 WARN (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-001\.\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 1610164 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-001\.\collection1\data\index
[junit4] 2> 1610164 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=14, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7476588148072613]
[junit4] 2> 1610164 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1b2b2f7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1760fdaf),segFN=segments_1,generation=1}
[junit4] 2> 1610164 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 1610165 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-001\.\collection1\data\
[junit4] 2> 1610166 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1610168 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1610170 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1610170 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1610171 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1610172 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy
[junit4] 2> 1610172 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,lazy,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,defaults,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
[junit4] 2> 1610173 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1610173 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
[junit4] 2> 1610173 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
[junit4] 2> 1610173 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=10, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 1610173 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1b2b2f7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1760fdaf),segFN=segments_1,generation=1}
[junit4] 2> 1610173 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 1610174 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@75952026[collection1] main
[junit4] 2> 1610174 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-001\.\collection1\conf
[junit4] 2> 1610174 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-001\.\collection1\conf}
[junit4] 2> 1610174 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-001\.\collection1\conf
[junit4] 2> 1610174 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 1610175 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 1610175 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1610175 INFO (searcherExecutor-4720-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@75952026[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1610175 INFO (coreLoadExecutor-4719-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 1610635 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\collection1
[junit4] 2> 1610641 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.e.j.s.Server jetty-9.2.13.v20150730
[junit4] 2> 1610643 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@44ea0db6{/solr,null,AVAILABLE}
[junit4] 2> 1610644 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.e.j.s.ServerConnector Started ServerConnector@55551811{HTTP/1.1}{127.0.0.1:49614}
[junit4] 2> 1610644 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.e.j.s.Server Started @1614920ms
[junit4] 2> 1610644 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\collection1\data, hostContext=/solr, hostPort=49614}
[junit4] 2> 1610644 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a
[junit4] 2> 1610644 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\'
[junit4] 2> 1610655 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\solr.xml
[junit4] 2> 1610659 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.
[junit4] 2> 1610659 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.CoreContainer New CoreContainer 1581038449
[junit4] 2> 1610659 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\]
[junit4] 2> 1610659 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.CoreContainer loading shared library: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\lib
[junit4] 2> 1610660 WARN (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\lib).
[junit4] 2> 1610666 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
[junit4] 2> 1610666 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1610666 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1610666 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1610667 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 1610667 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 1610667 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.CoresLocator Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.
[junit4] 2> 1610669 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.\collection1, absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.\collection1\, dataDir=data\}
[junit4] 2> 1610669 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.CoresLocator Found core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.\collection1\
[junit4] 2> 1610670 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.CoresLocator Found 1 core definitions
[junit4] 2> 1610671 INFO (coreLoadExecutor-4729-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.\collection1\'
[junit4] 2> 1610671 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.s.SolrDispatchFilter user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1
[junit4] 2> 1610671 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 1610684 INFO (coreLoadExecutor-4729-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 1610686 INFO (coreLoadExecutor-4729-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 1610690 INFO (coreLoadExecutor-4729-thread-1) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1610690 INFO (coreLoadExecutor-4729-thread-1) [ ] o.a.s.s.IndexSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.\collection1\conf\schema.xml
[junit4] 2> 1610701 INFO (coreLoadExecutor-4729-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1610702 INFO (coreLoadExecutor-4729-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 1610703 INFO (coreLoadExecutor-4729-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.\collection1\conf'
[junit4] 2> 1610703 INFO (coreLoadExecutor-4729-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.\collection1\
[junit4] 2> 1610703 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1610703 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.\collection1\], dataDir=[null]
[junit4] 2> 1610703 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
[junit4] 2> 1610703 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.\collection1\data\
[junit4] 2> 1610704 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.\collection1\data\index/
[junit4] 2> 1610704 WARN (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 1610704 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.\collection1\data\index
[junit4] 2> 1610704 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=14, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7476588148072613]
[junit4] 2> 1610704 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@4c960861 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e01af9b),segFN=segments_1,generation=1}
[junit4] 2> 1610705 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 1610705 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.\collection1\data\
[junit4] 2> 1610706 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1610707 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1610708 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1610709 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1610709 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1610710 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy
[junit4] 2> 1610711 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,lazy,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,defaults,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
[junit4] 2> 1610711 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1610711 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
[junit4] 2> 1610711 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
[junit4] 2> 1610711 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=10, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 1610712 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@4c960861 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e01af9b),segFN=segments_1,generation=1}
[junit4] 2> 1610712 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 1610712 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@711cf2bb[collection1] main
[junit4] 2> 1610712 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.\collection1\conf
[junit4] 2> 1610712 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.\collection1\conf}
[junit4] 2> 1610712 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.\collection1\conf
[junit4] 2> 1610713 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 1610714 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
[junit4] 2> 1610714 INFO (coreLoadExecutor-4729-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 1610714 INFO (searcherExecutor-4730-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@711cf2bb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1610716 INFO (qtp31055796-9968) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 1611172 INFO (qtp31055796-9969) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 1611175 INFO (qtp31055796-9971) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=0
[junit4] 2> 1611180 INFO (qtp31055796-9970) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={slave=false&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=0
[junit4] 2> 1611180 INFO (qtp257835909-9986) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=3
[junit4] 2> 1611183 INFO (qtp31055796-9972) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0]} 0 0
[junit4] 2> 1611185 INFO (qtp31055796-9973) [ x:collection1] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1611185 INFO (qtp31055796-9973) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1b2b2f7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1760fdaf),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1b2b2f7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1760fdaf),segFN=segments_2,generation=2}
[junit4] 2> 1611186 INFO (qtp31055796-9973) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 2
[junit4] 2> 1611186 INFO (qtp31055796-9973) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@389fcfac[collection1] main
[junit4] 2> 1611187 INFO (qtp31055796-9973) [ x:collection1] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 1611187 INFO (searcherExecutor-4720-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@389fcfac[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1)))}
[junit4] 2> 1611187 INFO (qtp31055796-9973) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 2
[junit4] 2> 1611189 WARN (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
[junit4] 2> 1611192 INFO (qtp31055796-9968) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 1611192 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Master's generation: 2
[junit4] 2> 1611192 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 1611192 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Starting replication process
[junit4] 2> 1611196 INFO (qtp31055796-9969) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&wt=javabin&version=2&command=filelist} status=0 QTime=2
[junit4] 2> 1611196 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Number of files in latest index in master: 10
[junit4] 2> 1611196 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.\collection1\data\index.20150918032557927
[junit4] 2> 1611197 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
[junit4] 2> 1611197 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=44, maxMergeAtOnceExplicit=36, maxMergedSegmentMB=52.0498046875, floorSegmentMB=0.96875, forceMergeDeletesPctAllowed=3.6869746276288295, segmentsPerTier=22.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.30605378399635336
[junit4] 2> 1611197 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@4c960861 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e01af9b),segFN=segments_1,generation=1}
[junit4] 2> 1611197 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 1611197 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1611198 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@4c960861 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e01af9b),segFN=segments_1,generation=1}
[junit4] 2> 1611198 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 1611198 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
[junit4] 2> 1611198 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Starting download to MockDirectoryWrapper(RAMDirectory@788ff48e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1f2f149a) fullCopy=false
[junit4] 2> 1611200 INFO (qtp31055796-9971) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.si&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611203 INFO (qtp31055796-9970) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0_Lucene50_0.doc&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611205 INFO (qtp31055796-9972) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0_Lucene50_0.tim&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611207 INFO (qtp31055796-9973) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.nvd&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611208 INFO (qtp31055796-9968) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.fdx&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611210 INFO (qtp31055796-9969) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0_Lucene50_0.tip&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611213 INFO (qtp31055796-9971) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.fdt&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611215 INFO (qtp31055796-9970) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.fnm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611217 INFO (qtp31055796-9972) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.nvm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611219 INFO (qtp31055796-9973) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=segments_2&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611219 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Total time taken for download: 0 secs
[junit4] 2> 1611220 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=36, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 1611221 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@4c960861 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e01af9b),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@4c960861 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e01af9b),segFN=segments_2,generation=2}
[junit4] 2> 1611221 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 2
[junit4] 2> 1611221 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1611222 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@435c55c1[collection1] main
[junit4] 2> 1611222 INFO (searcherExecutor-4730-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@435c55c1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1)))}
[junit4] 2> 1611223 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.\collection1\data\index.20150918032557927 [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.\collection1\data\index.20150918032557927;done=true>>]
[junit4] 2> 1611223 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.\collection1\data\index.20150918032557927
[junit4] 2> 1611223 INFO (qtp257835909-9987) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={wait=true&masterUrl=http://127.0.0.1:49611/solr/collection1/replication&command=fetchindex} status=0 QTime=34
[junit4] 2> 1611228 INFO (qtp31055796-9968) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={slave=false&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=0
[junit4] 2> 1611228 INFO (qtp257835909-9988) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=2
[junit4] 2> 1611232 INFO (qtp31055796-9969) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1]} 0 1
[junit4] 2> 1611234 INFO (qtp31055796-9971) [ x:collection1] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1611235 INFO (qtp31055796-9971) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=3
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1b2b2f7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1760fdaf),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1b2b2f7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1760fdaf),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1b2b2f7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1760fdaf),segFN=segments_3,generation=3}
[junit4] 2> 1611236 INFO (qtp31055796-9971) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 3
[junit4] 2> 1611236 INFO (qtp31055796-9971) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@2cc3ff7c[collection1] main
[junit4] 2> 1611236 INFO (qtp31055796-9971) [ x:collection1] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 1611236 INFO (searcherExecutor-4720-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2cc3ff7c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1) Uninverting(_1(6.0.0):C1)))}
[junit4] 2> 1611237 INFO (qtp31055796-9971) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 2
[junit4] 2> 1611238 WARN (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
[junit4] 2> 1611240 INFO (qtp31055796-9970) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 1611240 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Master's generation: 3
[junit4] 2> 1611240 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Slave's generation: 2
[junit4] 2> 1611240 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Starting replication process
[junit4] 2> 1611243 INFO (qtp31055796-9972) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&wt=javabin&version=2&command=filelist} status=0 QTime=0
[junit4] 2> 1611243 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Number of files in latest index in master: 19
[junit4] 2> 1611243 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.\collection1\data\index.20150918032557974
[junit4] 2> 1611243 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
[junit4] 2> 1611244 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=44, maxMergeAtOnceExplicit=36, maxMergedSegmentMB=52.0498046875, floorSegmentMB=0.96875, forceMergeDeletesPctAllowed=3.6869746276288295, segmentsPerTier=22.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.30605378399635336
[junit4] 2> 1611244 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@4c960861 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e01af9b),segFN=segments_2,generation=2}
[junit4] 2> 1611244 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 2
[junit4] 2> 1611244 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1611244 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@4c960861 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e01af9b),segFN=segments_2,generation=2}
[junit4] 2> 1611244 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 2
[junit4] 2> 1611245 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
[junit4] 2> 1611245 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Starting download to MockDirectoryWrapper(RAMDirectory@794ed187 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5758bbd3) fullCopy=false
[junit4] 2> 1611245 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists
[junit4] 2> 1611245 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0_Lucene50_0.doc because it already exists
[junit4] 2> 1611245 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0_Lucene50_0.tim because it already exists
[junit4] 2> 1611245 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.nvd because it already exists
[junit4] 2> 1611245 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.fdx because it already exists
[junit4] 2> 1611245 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0_Lucene50_0.tip because it already exists
[junit4] 2> 1611245 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.fdt because it already exists
[junit4] 2> 1611245 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.fnm because it already exists
[junit4] 2> 1611245 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.nvm because it already exists
[junit4] 2> 1611248 INFO (qtp31055796-9973) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1_Lucene50_0.doc&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611250 INFO (qtp31055796-9968) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1_Lucene50_0.tim&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611252 INFO (qtp31055796-9969) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.si&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611254 INFO (qtp31055796-9971) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.nvd&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611256 INFO (qtp31055796-9970) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.fdx&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611258 INFO (qtp31055796-9972) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.fnm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611261 INFO (qtp31055796-9973) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.nvm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611263 INFO (qtp31055796-9968) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.fdt&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611265 INFO (qtp31055796-9969) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1_Lucene50_0.tip&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611267 INFO (qtp31055796-9971) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=segments_3&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611267 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Total time taken for download: 0 secs
[junit4] 2> 1611269 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=36, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 1611269 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@4c960861 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e01af9b),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@4c960861 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e01af9b),segFN=segments_3,generation=3}
[junit4] 2> 1611269 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 3
[junit4] 2> 1611269 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1611270 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@36aabca5[collection1] main
[junit4] 2> 1611270 INFO (searcherExecutor-4730-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@36aabca5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1) Uninverting(_1(6.0.0):C1)))}
[junit4] 2> 1611270 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.\collection1\data\index.20150918032557974 [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.\collection1\data\index.20150918032557974;done=true>>]
[junit4] 2> 1611270 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.\collection1\data\index.20150918032557974
[junit4] 2> 1611270 INFO (qtp257835909-9989) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={wait=true&masterUrl=http://127.0.0.1:49611/solr/collection1/replication&command=fetchindex} status=0 QTime=33
[junit4] 2> 1611275 INFO (qtp31055796-9970) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={slave=false&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=0
[junit4] 2> 1611275 INFO (qtp257835909-9990) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=2
[junit4] 2> 1611279 INFO (qtp31055796-9972) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2]} 0 0
[junit4] 2> 1611281 INFO (qtp31055796-9973) [ x:collection1] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1611282 INFO (qtp31055796-9973) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=4
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1b2b2f7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1760fdaf),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1b2b2f7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1760fdaf),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1b2b2f7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1760fdaf),segFN=segments_3,generation=3}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1b2b2f7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1760fdaf),segFN=segments_4,generation=4}
[junit4] 2> 1611282 INFO (qtp31055796-9973) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 4
[junit4] 2> 1611282 INFO (qtp31055796-9973) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@1e4ed848[collection1] main
[junit4] 2> 1611283 INFO (qtp31055796-9973) [ x:collection1] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 1611283 INFO (searcherExecutor-4720-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1e4ed848[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1) Uninverting(_1(6.0.0):C1) Uninverting(_2(6.0.0):C1)))}
[junit4] 2> 1611283 INFO (qtp31055796-9973) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 1
[junit4] 2> 1611284 WARN (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
[junit4] 2> 1611287 INFO (qtp31055796-9968) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 1611287 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Master's generation: 4
[junit4] 2> 1611287 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Slave's generation: 3
[junit4] 2> 1611287 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Starting replication process
[junit4] 2> 1611289 INFO (qtp31055796-9969) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&wt=javabin&version=2&command=filelist} status=0 QTime=0
[junit4] 2> 1611290 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Number of files in latest index in master: 28
[junit4] 2> 1611290 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.\collection1\data\index.20150918032558021
[junit4] 2> 1611290 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
[junit4] 2> 1611290 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=44, maxMergeAtOnceExplicit=36, maxMergedSegmentMB=52.0498046875, floorSegmentMB=0.96875, forceMergeDeletesPctAllowed=3.6869746276288295, segmentsPerTier=22.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.30605378399635336
[junit4] 2> 1611291 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@4c960861 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e01af9b),segFN=segments_3,generation=3}
[junit4] 2> 1611291 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 3
[junit4] 2> 1611291 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1611291 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@4c960861 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e01af9b),segFN=segments_3,generation=3}
[junit4] 2> 1611291 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 3
[junit4] 2> 1611291 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
[junit4] 2> 1611291 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Starting download to MockDirectoryWrapper(RAMDirectory@75510157 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@43ccd54d) fullCopy=false
[junit4] 2> 1611291 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists
[junit4] 2> 1611291 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0_Lucene50_0.doc because it already exists
[junit4] 2> 1611291 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0_Lucene50_0.tim because it already exists
[junit4] 2> 1611291 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.nvd because it already exists
[junit4] 2> 1611291 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.fdx because it already exists
[junit4] 2> 1611291 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0_Lucene50_0.tip because it already exists
[junit4] 2> 1611291 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.fdt because it already exists
[junit4] 2> 1611291 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.fnm because it already exists
[junit4] 2> 1611291 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.nvm because it already exists
[junit4] 2> 1611291 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _1_Lucene50_0.doc because it already exists
[junit4] 2> 1611291 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _1_Lucene50_0.tim because it already exists
[junit4] 2> 1611291 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _1.si because it already exists
[junit4] 2> 1611291 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _1.nvd because it already exists
[junit4] 2> 1611291 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _1.fdx because it already exists
[junit4] 2> 1611291 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _1.fnm because it already exists
[junit4] 2> 1611292 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _1.nvm because it already exists
[junit4] 2> 1611292 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _1.fdt because it already exists
[junit4] 2> 1611292 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _1_Lucene50_0.tip because it already exists
[junit4] 2> 1611294 INFO (qtp31055796-9971) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2.nvd&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611297 INFO (qtp31055796-9970) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2.si&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611300 INFO (qtp31055796-9972) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2.fdt&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611302 INFO (qtp31055796-9973) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2.fnm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611304 INFO (qtp31055796-9968) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2.nvm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611306 INFO (qtp31055796-9969) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2.fdx&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611308 INFO (qtp31055796-9971) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2_Lucene50_0.doc&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611310 INFO (qtp31055796-9970) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2_Lucene50_0.tim&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611312 INFO (qtp31055796-9972) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2_Lucene50_0.tip&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611314 INFO (qtp31055796-9973) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=segments_4&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1611314 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Total time taken for download: 0 secs
[junit4] 2> 1611316 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=36, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 1611316 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@4c960861 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e01af9b),segFN=segments_3,generation=3}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@4c960861 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e01af9b),segFN=segments_4,generation=4}
[junit4] 2> 1611316 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 4
[junit4] 2> 1611317 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1611317 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@2cceed93[collection1] main
[junit4] 2> 1611317 INFO (searcherExecutor-4730-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2cceed93[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1) Uninverting(_1(6.0.0):C1) Uninverting(_2(6.0.0):C1)))}
[junit4] 2> 1611318 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.\collection1\data\index.20150918032558021 [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.\collection1\data\index.20150918032558021;done=true>>]
[junit4] 2> 1611318 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-002\.\collection1\data\index.20150918032558021
[junit4] 2> 1611318 INFO (qtp257835909-9991) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={wait=true&masterUrl=http://127.0.0.1:49611/solr/collection1/replication&command=fetchindex} status=0 QTime=35
[junit4] 2> 1611319 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-003\collection1
[junit4] 2> 1611327 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.e.j.s.Server jetty-9.2.13.v20150730
[junit4] 2> 1611329 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1ee93cdb{/solr,null,AVAILABLE}
[junit4] 2> 1611330 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.e.j.s.ServerConnector Started ServerConnector@67294fa8{HTTP/1.1}{127.0.0.1:49621}
[junit4] 2> 1611330 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.e.j.s.Server Started @1615607ms
[junit4] 2> 1611330 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-003\collection1\data, hostContext=/solr, hostPort=49621}
[junit4] 2> 1611330 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a
[junit4] 2> 1611330 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-003\'
[junit4] 2> 1611348 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-003\solr.xml
[junit4] 2> 1611353 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-003\.
[junit4] 2> 1611353 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.CoreContainer New CoreContainer 1424508410
[junit4] 2> 1611353 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-003\]
[junit4] 2> 1611353 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.CoreContainer loading shared library: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-003\lib
[junit4] 2> 1611354 WARN (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-003\lib).
[junit4] 2> 1611361 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
[junit4] 2> 1611363 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1611363 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1611363 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1611363 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 1611364 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 1611364 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.CoresLocator Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-003\.
[junit4] 2> 1611366 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-003\.\collection1, absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-003\.\collection1\, dataDir=data\}
[junit4] 2> 1611366 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.CoresLocator Found core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-003\.\collection1\
[junit4] 2> 1611367 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.c.CoresLocator Found 1 core definitions
[junit4] 2> 1611367 INFO (coreLoadExecutor-4743-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-003\.\collection1\'
[junit4] 2> 1611368 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.s.SolrDispatchFilter user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1
[junit4] 2> 1611368 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[6927A5540FFC0008]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 1611384 INFO (coreLoadExecutor-4743-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 1611386 INFO (coreLoadExecutor-4743-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 1611398 INFO (coreLoadExecutor-4743-thread-1) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1611398 INFO (coreLoadExecutor-4743-thread-1) [ ] o.a.s.s.IndexSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-003\.\collection1\conf\schema.xml
[junit4] 2> 1611400 INFO (coreLoadExecutor-4743-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1611404 INFO (coreLoadExecutor-4743-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 1611406 INFO (coreLoadExecutor-4743-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-003\.\collection1\conf'
[junit4] 2> 1611406 INFO (coreLoadExecutor-4743-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-003\.\collection1\
[junit4] 2> 1611406 INFO (coreLoadExecutor-4743-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1611407 INFO (coreLoadExecutor-4743-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-003\.\collection1\], dataDir=[null]
[junit4] 2> 1611407 INFO (coreLoadExecutor-4743-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
[junit4] 2> 1611407 INFO (coreLoadExecutor-4743-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-003\.\collection1\data\
[junit4] 2> 1611407 INFO (coreLoadExecutor-4743-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-003\.\collection1\data\index/
[junit4] 2> 1611407 WARN (coreLoadExecutor-4743-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-003\.\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 1611407 INFO (coreLoadExecutor-4743-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-003\.\collection1\data\index
[junit4] 2> 1611408 INFO (coreLoadExecutor-4743-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=14, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7476588148072613]
[junit4] 2> 1611408 INFO (coreLoadExecutor-4743-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDir
[...truncated too long message...]
plicateAfterStartupWithNoActivity-seed#[6927A5540FFC0008]) [ x:collection1] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@6ef579fb{/solr,null,UNAVAILABLE}
[junit4] 2> 1697318 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[6927A5540FFC0008]) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@1077e82f{HTTP/1.1}{127.0.0.1:0}
[junit4] 2> 1697318 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[6927A5540FFC0008]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=294470213
[junit4] 2> 1697318 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[6927A5540FFC0008]) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@3ecdfb87
[junit4] 2> 1697318 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[6927A5540FFC0008]) [ x:collection1] o.a.s.u.UpdateHandler 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> 1697318 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[6927A5540FFC0008]) [ x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 1697318 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[6927A5540FFC0008]) [ x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 1697318 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[6927A5540FFC0008]) [ x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
[junit4] 2> 1697321 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[6927A5540FFC0008]) [ x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
[junit4] 2> 1697326 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[6927A5540FFC0008]) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing NRTCachingDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 1697326 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[6927A5540FFC0008]) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-028\collection1\data\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-028\collection1\data\index;done=false>>]
[junit4] 2> 1697326 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[6927A5540FFC0008]) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-028\collection1\data\index
[junit4] 2> 1697326 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[6927A5540FFC0008]) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-028\collection1\data [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-028\collection1\data;done=false>>]
[junit4] 2> 1697326 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[6927A5540FFC0008]) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001\solr-instance-028\collection1\data
[junit4] 2> 1697327 INFO (TEST-TestReplicationHandler.doTestReplicateAfterStartupWithNoActivity-seed#[6927A5540FFC0008]) [ x:collection1] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@64d1cbf2{/solr,null,UNAVAILABLE}
[junit4] 2> 1697328 INFO (SUITE-TestReplicationHandler-seed#[6927A5540FFC0008]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandler_6927A5540FFC0008-001
[junit4] 2> NOTE: test params are: codec=Lucene53, sim=ClassicSimilarity, locale=sr_RS, timezone=Europe/Tallinn
[junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0_60 (64-bit)/cpus=3,threads=1,free=191057984,total=508559360
[junit4] 2> NOTE: All tests run in this JVM: [TestSolrDeletionPolicy2, SuggesterWFSTTest, CSVRequestHandlerTest, TestReversedWildcardFilterFactory, TestSolrConfigHandlerConcurrent, CdcrRequestHandlerTest, TestIndexingPerformance, TestDefaultStatsCache, CollectionsAPIDistributedZkTest, TestCloudManagedSchema, SpellCheckCollatorTest, TestRecoveryHdfs, CollectionTooManyReplicasTest, TestSortingResponseWriter, SecurityConfHandlerTest, StressHdfsTest, TermVectorComponentTest, SearchHandlerTest, WordBreakSolrSpellCheckerTest, TestCollectionAPI, AnalysisErrorHandlingTest, TestNonDefinedSimilarityFactory, TestRandomRequestDistribution, BigEndianAscendingWordDeserializerTest, HLLUtilTest, TestPHPSerializedResponseWriter, UUIDFieldTest, UpdateRequestProcessorFactoryTest, TestManagedSynonymFilterFactory, LeaderElectionIntegrationTest, ResponseHeaderTest, ZkStateReaderTest, TestRealTimeGet, TestPerFieldSimilarity, ShardRoutingCustomTest, FieldMutatingUpdateProcessorTest, TestRestManager, UUIDUpdateProcessorFallbackTest, NoCacheHeaderTest, SortByFunctionTest, QueryResultKeyTest, BasicFunctionalityTest, SSLMigrationTest, SolrInfoMBeanTest, TestSolrQueryParser, DistanceUnitsTest, ZkStateWriterTest, TestConfigSetImmutable, HdfsChaosMonkeySafeLeaderTest, TestDefaultSearchFieldResource, TestRestoreCore, TestJoin, TestStressUserVersions, TestImplicitCoreProperties, TestSolrIndexConfig, CurrencyFieldOpenExchangeTest, SolrIndexSplitterTest, TestHdfsUpdateLog, RequestLoggingTest, DistributedQueueTest, NotRequiredUniqueKeyTest, DirectUpdateHandlerOptimizeTest, OutputWriterTest, MergeStrategyTest, TestOverriddenPrefixQueryForCustomFieldType, TestFastOutputStream, FileBasedSpellCheckerTest, LukeRequestHandlerTest, TestFieldResource, RAMDirectoryFactoryTest, SignatureUpdateProcessorFactoryTest, TestValueSourceCache, TestRandomFaceting, TestSmileRequest, ShardSplitTest, TestMiniSolrCloudClusterSSL, TestMissingGroups, SolrTestCaseJ4Test, MultiTermTest, AddBlockUpdateTest, JavabinLoaderTest, PreAnalyzedFieldTest, CachingDirectoryFactoryTest, HdfsNNFailoverTest, TestRangeQuery, TestShortCircuitedRequests, SpellingQueryConverterTest, SaslZkACLProviderTest, ConvertedLegacyTest, TestPKIAuthenticationPlugin, CdcrReplicationDistributedZkTest, TestMaxScoreQueryParser, SpatialRPTFieldTypeTest, BadIndexSchemaTest, TestHighFrequencyDictionaryFactory, TestSha256AuthenticationProvider, BasicDistributedZk2Test, TestDistributedGrouping, CloudMLTQParserTest, TestExclusionRuleCollectionAccess, HdfsLockFactoryTest, TestSchemaNameResource, CacheHeaderTest, TestSuggestSpellingConverter, TestConfigSetsAPIZkFailure, FullSolrCloudDistribCmdsTest, TestManagedSchemaFieldTypeResource, DistribJoinFromCollectionTest, TestIndexSearcher, TestCustomDocTransformer, RecoveryAfterSoftCommitTest, TestCSVResponseWriter, SynonymTokenizerTest, LoggingHandlerTest, TestCharFilters, CollectionStateFormat2Test, ShowFileRequestHandlerTest, TestSolr4Spatial2, TestDefaultSimilarityFactory, BasicZkTest, TestStressRecovery, TestBM25SimilarityFactory, TestConfigOverlay, TestSolrQueryParserDefaultOperatorResource, TestCoreDiscovery, CdcrUpdateLogTest, TestWriterPerf, CollectionReloadTest, TestSolrDynamicMBean, AnalyticsMergeStrategyTest, TestReload, BasicDistributedZkTest, ChaosMonkeySafeLeaderTest, UnloadDistributedZkTest, OpenCloseCoreStressTest, ShardRoutingTest, RecoveryZkTest, TestReplicationHandler]
[junit4] Completed [278/546] on J1 in 87.27s, 13 tests, 1 failure <<< FAILURES!
[...truncated 856 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:775: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:719: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:59: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:233: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:514: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1432: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:987: There were test failures: 546 suites, 2145 tests, 1 failure, 81 ignored (45 assumptions)
Total time: 68 minutes 24 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any