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/12/10 01:52:53 UTC
[JENKINS] Lucene-Solr-trunk-Windows (64bit/jdk1.8.0_66) - Build #
5459 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/5459/
Java: 64bit/jdk1.8.0_66 -XX:-UseCompressedOops -XX:+UseG1GC
1 tests failed.
FAILED: org.apache.solr.handler.TestReplicationHandlerBackup.doTestBackup
Error Message:
Failed to create backup
Stack Trace:
java.lang.AssertionError: Failed to create backup
at __randomizedtesting.SeedInfo.seed([6E9F182550A30A29:2F143840771DF966]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.apache.solr.handler.CheckBackupStatus.fetchStatus(CheckBackupStatus.java:51)
at org.apache.solr.handler.TestReplicationHandlerBackup.doTestBackup(TestReplicationHandlerBackup.java:197)
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:1764)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
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:367)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
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:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
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:367)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 10951 lines...]
[junit4] Suite: org.apache.solr.handler.TestReplicationHandlerBackup
[junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\init-core-data-001
[junit4] 2> 2840914 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] o.a.s.SolrTestCaseJ4 ###Starting doTestBackup
[junit4] 2> 2840915 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\collection1
[junit4] 2> 2840926 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] o.e.j.s.Server jetty-9.3.6.v20151106
[junit4] 2> 2840928 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@209d8747{/solr,null,AVAILABLE}
[junit4] 2> 2840930 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] o.e.j.s.ServerConnector Started ServerConnector@1842e833{HTTP/1.1,[http/1.1]}{127.0.0.1:50699}
[junit4] 2> 2840931 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] o.e.j.s.Server Started @2836586ms
[junit4] 2> 2840931 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\collection1\data, hostContext=/solr, hostPort=50699}
[junit4] 2> 2840931 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a
[junit4] 2> 2840931 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001'
[junit4] 2> 2840931 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 2840931 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 2840932 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\solr.xml
[junit4] 2> 2840940 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.
[junit4] 2> 2840941 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] o.a.s.c.CoreContainer New CoreContainer 55843146
[junit4] 2> 2840941 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001]
[junit4] 2> 2840941 WARN (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] o.a.s.c.CoreContainer Couldn't add files from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\lib to classpath: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\lib
[junit4] 2> 2840941 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] 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> 2840944 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 2840946 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2840946 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2840946 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 2840946 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 2840948 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.
[junit4] 2> 2840951 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data\}
[junit4] 2> 2840951 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] o.a.s.c.CorePropertiesLocator Found core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1
[junit4] 2> 2840951 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
[junit4] 2> 2840952 INFO (coreLoadExecutor-8117-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\collection1'
[junit4] 2> 2840952 INFO (coreLoadExecutor-8117-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 2840952 INFO (coreLoadExecutor-8117-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 2840952 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] o.a.s.s.SolrDispatchFilter user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1
[junit4] 2> 2840952 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 2840967 INFO (coreLoadExecutor-8117-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 2840969 INFO (coreLoadExecutor-8117-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 2840974 INFO (coreLoadExecutor-8117-thread-1) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 2840977 INFO (coreLoadExecutor-8117-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 2840981 INFO (coreLoadExecutor-8117-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 2840987 INFO (coreLoadExecutor-8117-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\collection1'
[junit4] 2> 2840987 INFO (coreLoadExecutor-8117-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1
[junit4] 2> 2840987 INFO (coreLoadExecutor-8117-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 2840987 INFO (coreLoadExecutor-8117-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\collection1], dataDir=[C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\]
[junit4] 2> 2840987 INFO (coreLoadExecutor-8117-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
[junit4] 2> 2840988 INFO (coreLoadExecutor-8117-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\
[junit4] 2> 2840988 INFO (coreLoadExecutor-8117-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\index/
[junit4] 2> 2840988 WARN (coreLoadExecutor-8117-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 2840988 INFO (coreLoadExecutor-8117-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\index
[junit4] 2> 2840988 INFO (coreLoadExecutor-8117-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=19, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=48.056640625, floorSegmentMB=1.509765625, forceMergeDeletesPctAllowed=14.590512235846814, segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5979371609037587
[junit4] 2> 2840989 INFO (coreLoadExecutor-8117-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@78aa3ccf lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6b0ce9b4),segFN=segments_1,generation=1}
[junit4] 2> 2840989 INFO (coreLoadExecutor-8117-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 2840989 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\
[junit4] 2> 2840990 INFO (coreLoadExecutor-8117-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 2840996 INFO (coreLoadExecutor-8117-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 2840997 INFO (coreLoadExecutor-8117-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 2840998 INFO (coreLoadExecutor-8117-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 2840998 INFO (coreLoadExecutor-8117-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 2840999 INFO (coreLoadExecutor-8117-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
[junit4] 2> 2841000 INFO (coreLoadExecutor-8117-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 2841000 INFO (coreLoadExecutor-8117-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2841000 INFO (coreLoadExecutor-8117-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2841000 INFO (coreLoadExecutor-8117-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=13, maxMergeAtOnceExplicit=22, maxMergedSegmentMB=45.7578125, floorSegmentMB=0.48046875, forceMergeDeletesPctAllowed=14.347045572391076, segmentsPerTier=37.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 2841000 INFO (coreLoadExecutor-8117-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@78aa3ccf lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6b0ce9b4),segFN=segments_1,generation=1}
[junit4] 2> 2841000 INFO (coreLoadExecutor-8117-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 2841001 INFO (coreLoadExecutor-8117-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@31664577[collection1] main
[junit4] 2> 2841002 INFO (coreLoadExecutor-8117-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\collection1\conf
[junit4] 2> 2841002 INFO (coreLoadExecutor-8117-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\collection1\conf}
[junit4] 2> 2841002 INFO (coreLoadExecutor-8117-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\collection1\conf
[junit4] 2> 2841002 INFO (coreLoadExecutor-8117-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 2841003 INFO (coreLoadExecutor-8117-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema-replication2.xml:schema.xml
[junit4] 2> 2841003 INFO (coreLoadExecutor-8117-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 2841003 INFO (searcherExecutor-8118-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@31664577[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2841003 INFO (coreLoadExecutor-8117-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 2841503 INFO (qtp361078011-20052) [ x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 2841503 INFO (qtp361078011-20052) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 0
[junit4] 2> 2841506 INFO (qtp361078011-20053) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0]} 0 0
[junit4] 2> 2841508 INFO (qtp361078011-20054) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1]} 0 0
[junit4] 2> 2841510 INFO (qtp361078011-20055) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2]} 0 0
[junit4] 2> 2841513 INFO (qtp361078011-20056) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[3]} 0 0
[junit4] 2> 2841515 INFO (qtp361078011-20057) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[4]} 0 0
[junit4] 2> 2841517 INFO (qtp361078011-20050) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[5]} 0 0
[junit4] 2> 2841519 INFO (qtp361078011-20052) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[6]} 0 0
[junit4] 2> 2841521 INFO (qtp361078011-20053) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[7]} 0 0
[junit4] 2> 2841523 INFO (qtp361078011-20054) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[8]} 0 0
[junit4] 2> 2841525 INFO (qtp361078011-20055) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[9]} 0 0
[junit4] 2> 2841528 INFO (qtp361078011-20056) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[10]} 0 0
[junit4] 2> 2841530 INFO (qtp361078011-20057) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[11]} 0 0
[junit4] 2> 2841532 INFO (qtp361078011-20050) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[12]} 0 0
[junit4] 2> 2841534 INFO (qtp361078011-20052) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[13]} 0 0
[junit4] 2> 2841537 INFO (qtp361078011-20053) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[14]} 0 0
[junit4] 2> 2841539 INFO (qtp361078011-20053) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[15]} 0 0
[junit4] 2> 2841541 INFO (qtp361078011-20055) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[16]} 0 0
[junit4] 2> 2841544 INFO (qtp361078011-20056) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[17]} 0 0
[junit4] 2> 2841546 INFO (qtp361078011-20057) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[18]} 0 0
[junit4] 2> 2841548 INFO (qtp361078011-20050) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[19]} 0 0
[junit4] 2> 2841550 INFO (qtp361078011-20052) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[20]} 0 0
[junit4] 2> 2841552 INFO (qtp361078011-20054) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[21]} 0 0
[junit4] 2> 2841554 INFO (qtp361078011-20053) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[22]} 0 0
[junit4] 2> 2841556 INFO (qtp361078011-20053) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[23]} 0 0
[junit4] 2> 2841559 INFO (qtp361078011-20053) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[24]} 0 0
[junit4] 2> 2841561 INFO (qtp361078011-20057) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[25]} 0 0
[junit4] 2> 2841563 INFO (qtp361078011-20050) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2841565 INFO (qtp361078011-20050) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@78aa3ccf lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6b0ce9b4),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@78aa3ccf lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6b0ce9b4),segFN=segments_2,generation=2}
[junit4] 2> 2841567 INFO (qtp361078011-20050) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 2
[junit4] 2> 2841569 INFO (Thread-7489) [ x:collection1] o.a.s.h.SnapShooter Creating backup snapshot <not named> at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\
[junit4] 2> 2841570 INFO (qtp361078011-20050) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@159deca3[collection1] main
[junit4] 2> 2841570 INFO (searcherExecutor-8118-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@159deca3[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C26)))}
[junit4] 2> 2841570 INFO (qtp361078011-20050) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2841570 INFO (qtp361078011-20050) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 6
[junit4] 2> 2841578 INFO (qtp361078011-20054) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=backup} status=0 QTime=2
[junit4] 2> 2841580 INFO (Thread-7490) [ x:collection1] o.a.s.h.SnapShooter Creating backup snapshot <not named> at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\
[junit4] 2> 2841591 INFO (Thread-7490) [ x:collection1] o.a.s.h.SnapShooter Done creating backup snapshot: <not named> at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\
[junit4] 2> 2841594 INFO (qtp361078011-20055) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=8
[junit4] 2> 2841626 ERROR (Thread-7489) [ x:collection1] o.a.s.h.SnapShooter Exception while creating snapshot
[junit4] 2> java.nio.file.NoSuchFileException: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\collection1\data\snapshot.20151209184814469\_0.fdx
[junit4] 2> at sun.nio.fs.WindowsException.translateToIOException(WindowsException.java:79)
[junit4] 2> at sun.nio.fs.WindowsException.rethrowAsIOException(WindowsException.java:97)
[junit4] 2> at sun.nio.fs.WindowsException.rethrowAsIOException(WindowsException.java:102)
[junit4] 2> at sun.nio.fs.WindowsFileSystemProvider.newByteChannel(WindowsFileSystemProvider.java:230)
[junit4] 2> at java.nio.file.spi.FileSystemProvider.newOutputStream(FileSystemProvider.java:434)
[junit4] 2> at java.nio.file.Files.newOutputStream(Files.java:216)
[junit4] 2> at org.apache.lucene.store.FSDirectory$FSIndexOutput.<init>(FSDirectory.java:301)
[junit4] 2> at org.apache.lucene.store.FSDirectory$FSIndexOutput.<init>(FSDirectory.java:297)
[junit4] 2> at org.apache.lucene.store.FSDirectory.createOutput(FSDirectory.java:232)
[junit4] 2> at org.apache.lucene.store.Directory.copyFrom(Directory.java:155)
[junit4] 2> at org.apache.solr.handler.SnapShooter.copyFiles(SnapShooter.java:203)
[junit4] 2> at org.apache.solr.handler.SnapShooter.createSnapshot(SnapShooter.java:136)
[junit4] 2> at org.apache.solr.handler.SnapShooter$1.run(SnapShooter.java:85)
[junit4] 2> 2842648 INFO (qtp361078011-20055) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=backup} status=0 QTime=1
[junit4] 2> 2842648 INFO (Thread-7491) [ x:collection1] o.a.s.h.SnapShooter Creating backup snapshot <not named> at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\
[junit4] 2> 2842650 INFO (qtp361078011-20053) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 2842651 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] o.a.s.SolrTestCaseJ4 ###Ending doTestBackup
[junit4] 2> 2842652 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@1842e833{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 2842652 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=55843146
[junit4] 2> 2842652 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@3fa1e35a
[junit4] 2> 2842652 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ x:collection1] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=26,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
[junit4] 2> 2842652 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 2842652 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 2842652 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
[junit4] 2> 2842652 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
[junit4] 2> 2842652 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 2842658 INFO (Thread-7491) [ x:collection1] o.a.s.h.SnapShooter Done creating backup snapshot: <not named> at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\
[junit4] 2> 2842751 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\;done=false>>]
[junit4] 2> 2842751 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\
[junit4] 2> 2842751 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\index;done=false>>]
[junit4] 2> 2842751 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\index
[junit4] 2> 2842751 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [ x:collection1] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@209d8747{/solr,null,UNAVAILABLE}
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestReplicationHandlerBackup -Dtests.method=doTestBackup -Dtests.seed=6E9F182550A30A29 -Dtests.slow=true -Dtests.locale=cs -Dtests.timezone=Pacific/Galapagos -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] FAILURE 1.84s J1 | TestReplicationHandlerBackup.doTestBackup <<<
[junit4] > Throwable #1: java.lang.AssertionError: Failed to create backup
[junit4] > at __randomizedtesting.SeedInfo.seed([6E9F182550A30A29:2F143840771DF966]:0)
[junit4] > at org.apache.solr.handler.CheckBackupStatus.fetchStatus(CheckBackupStatus.java:51)
[junit4] > at org.apache.solr.handler.TestReplicationHandlerBackup.doTestBackup(TestReplicationHandlerBackup.java:197)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 2842757 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testBackupOnCommit
[junit4] 2> 2842763 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\collection1
[junit4] 2> 2842771 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] o.e.j.s.Server jetty-9.3.6.v20151106
[junit4] 2> 2842772 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5f8f4fdf{/solr,null,AVAILABLE}
[junit4] 2> 2842773 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] o.e.j.s.ServerConnector Started ServerConnector@6b36bda1{HTTP/1.1,[http/1.1]}{127.0.0.1:50719}
[junit4] 2> 2842773 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] o.e.j.s.Server Started @2838325ms
[junit4] 2> 2842773 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\collection1\data, hostContext=/solr, hostPort=50719}
[junit4] 2> 2842773 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a
[junit4] 2> 2842773 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002'
[junit4] 2> 2842774 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 2842774 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 2842774 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\solr.xml
[junit4] 2> 2842777 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.
[junit4] 2> 2842777 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] o.a.s.c.CoreContainer New CoreContainer 238330731
[junit4] 2> 2842777 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002]
[junit4] 2> 2842777 WARN (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] o.a.s.c.CoreContainer Couldn't add files from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\lib to classpath: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\lib
[junit4] 2> 2842778 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] 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> 2842778 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 2842779 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2842779 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2842779 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 2842779 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 2842780 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.
[junit4] 2> 2842782 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data\}
[junit4] 2> 2842782 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] o.a.s.c.CorePropertiesLocator Found core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1
[junit4] 2> 2842783 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
[junit4] 2> 2842783 INFO (coreLoadExecutor-8127-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\collection1'
[junit4] 2> 2842783 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] o.a.s.s.SolrDispatchFilter user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1
[junit4] 2> 2842784 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 2842784 INFO (coreLoadExecutor-8127-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 2842784 INFO (coreLoadExecutor-8127-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 2842790 INFO (coreLoadExecutor-8127-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 2842793 INFO (coreLoadExecutor-8127-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 2842797 INFO (coreLoadExecutor-8127-thread-1) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 2842800 INFO (coreLoadExecutor-8127-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 2842801 INFO (coreLoadExecutor-8127-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 2842802 INFO (coreLoadExecutor-8127-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\collection1'
[junit4] 2> 2842802 INFO (coreLoadExecutor-8127-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1
[junit4] 2> 2842803 INFO (coreLoadExecutor-8127-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 2842803 INFO (coreLoadExecutor-8127-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\collection1], dataDir=[C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1\data\]
[junit4] 2> 2842803 INFO (coreLoadExecutor-8127-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
[junit4] 2> 2842804 INFO (coreLoadExecutor-8127-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1\data\
[junit4] 2> 2842804 INFO (coreLoadExecutor-8127-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1\data\index/
[junit4] 2> 2842804 WARN (coreLoadExecutor-8127-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 2842804 INFO (coreLoadExecutor-8127-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1\data\index
[junit4] 2> 2842804 INFO (coreLoadExecutor-8127-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=19, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=48.056640625, floorSegmentMB=1.509765625, forceMergeDeletesPctAllowed=14.590512235846814, segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5979371609037587
[junit4] 2> 2842804 INFO (coreLoadExecutor-8127-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1e56787d lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@531455cb),segFN=segments_1,generation=1}
[junit4] 2> 2842804 INFO (coreLoadExecutor-8127-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 2842805 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1\data\
[junit4] 2> 2842806 INFO (coreLoadExecutor-8127-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 2842807 INFO (coreLoadExecutor-8127-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 2842808 INFO (coreLoadExecutor-8127-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 2842809 INFO (coreLoadExecutor-8127-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 2842810 INFO (coreLoadExecutor-8127-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 2842810 INFO (coreLoadExecutor-8127-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
[junit4] 2> 2842811 INFO (coreLoadExecutor-8127-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 2842811 INFO (coreLoadExecutor-8127-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2842811 INFO (coreLoadExecutor-8127-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2842811 INFO (coreLoadExecutor-8127-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=13, maxMergeAtOnceExplicit=22, maxMergedSegmentMB=45.7578125, floorSegmentMB=0.48046875, forceMergeDeletesPctAllowed=14.347045572391076, segmentsPerTier=37.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 2842812 INFO (coreLoadExecutor-8127-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1e56787d lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@531455cb),segFN=segments_1,generation=1}
[junit4] 2> 2842812 INFO (coreLoadExecutor-8127-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 2842812 INFO (coreLoadExecutor-8127-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@594587a3[collection1] main
[junit4] 2> 2842812 INFO (coreLoadExecutor-8127-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\collection1\conf
[junit4] 2> 2842812 INFO (coreLoadExecutor-8127-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\collection1\conf}
[junit4] 2> 2842812 INFO (coreLoadExecutor-8127-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\collection1\conf
[junit4] 2> 2842813 INFO (coreLoadExecutor-8127-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 2842813 INFO (coreLoadExecutor-8127-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema-replication2.xml:schema.xml
[junit4] 2> 2842813 INFO (coreLoadExecutor-8127-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 2842813 INFO (coreLoadExecutor-8127-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 2842813 INFO (searcherExecutor-8128-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@594587a3[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2843280 INFO (qtp1716486702-20076) [ x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 2843280 INFO (qtp1716486702-20076) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 0
[junit4] 2> 2843282 INFO (qtp1716486702-20077) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0]} 0 0
[junit4] 2> 2843285 INFO (qtp1716486702-20078) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1]} 0 0
[junit4] 2> 2843287 INFO (qtp1716486702-20079) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2]} 0 0
[junit4] 2> 2843289 INFO (qtp1716486702-20080) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[3]} 0 0
[junit4] 2> 2843291 INFO (qtp1716486702-20081) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[4]} 0 0
[junit4] 2> 2843293 INFO (qtp1716486702-20074) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[5]} 0 0
[junit4] 2> 2843295 INFO (qtp1716486702-20076) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[6]} 0 0
[junit4] 2> 2843296 INFO (qtp1716486702-20077) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[7]} 0 0
[junit4] 2> 2843298 INFO (qtp1716486702-20078) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[8]} 0 0
[junit4] 2> 2843300 INFO (qtp1716486702-20079) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[9]} 0 0
[junit4] 2> 2843302 INFO (qtp1716486702-20080) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[10]} 0 0
[junit4] 2> 2843304 INFO (qtp1716486702-20081) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[11]} 0 0
[junit4] 2> 2843306 INFO (qtp1716486702-20074) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[12]} 0 0
[junit4] 2> 2843308 INFO (qtp1716486702-20076) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[13]} 0 0
[junit4] 2> 2843310 INFO (qtp1716486702-20077) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[14]} 0 0
[junit4] 2> 2843312 INFO (qtp1716486702-20078) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[15]} 0 0
[junit4] 2> 2843314 INFO (qtp1716486702-20079) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[16]} 0 0
[junit4] 2> 2843316 INFO (qtp1716486702-20080) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[17]} 0 0
[junit4] 2> 2843318 INFO (qtp1716486702-20081) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[18]} 0 0
[junit4] 2> 2843319 INFO (qtp1716486702-20074) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[19]} 0 0
[junit4] 2> 2843321 INFO (qtp1716486702-20076) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[20]} 0 0
[junit4] 2> 2843323 INFO (qtp1716486702-20077) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[21]} 0 0
[junit4] 2> 2843326 INFO (qtp1716486702-20078) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[22]} 0 0
[junit4] 2> 2843328 INFO (qtp1716486702-20079) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[23]} 0 0
[junit4] 2> 2843330 INFO (qtp1716486702-20080) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[24]} 0 0
[junit4] 2> 2843332 INFO (qtp1716486702-20081) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[25]} 0 0
[junit4] 2> 2843334 INFO (qtp1716486702-20074) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[26]} 0 0
[junit4] 2> 2843336 INFO (qtp1716486702-20076) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[27]} 0 0
[junit4] 2> 2843338 INFO (qtp1716486702-20077) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[28]} 0 0
[junit4] 2> 2843340 INFO (qtp1716486702-20078) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[29]} 0 0
[junit4] 2> 2843343 INFO (qtp1716486702-20078) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[30]} 0 0
[junit4] 2> 2843345 INFO (qtp1716486702-20078) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[31]} 0 0
[junit4] 2> 2843347 INFO (qtp1716486702-20078) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[32]} 0 0
[junit4] 2> 2843349 INFO (qtp1716486702-20078) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[33]} 0 0
[junit4] 2> 2843351 INFO (qtp1716486702-20078) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[34]} 0 0
[junit4] 2> 2843353 INFO (qtp1716486702-20077) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[35]} 0 0
[junit4] 2> 2843355 INFO (qtp1716486702-20079) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[36]} 0 0
[junit4] 2> 2843357 INFO (qtp1716486702-20080) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[37]} 0 0
[junit4] 2> 2843359 INFO (qtp1716486702-20081) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[38]} 0 0
[junit4] 2> 2843361 INFO (qtp1716486702-20074) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[39]} 0 0
[junit4] 2> 2843364 INFO (qtp1716486702-20076) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[40]} 0 0
[junit4] 2> 2843366 INFO (qtp1716486702-20076) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[41]} 0 0
[junit4] 2> 2843368 INFO (qtp1716486702-20077) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[42]} 0 0
[junit4] 2> 2843369 INFO (qtp1716486702-20079) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[43]} 0 0
[junit4] 2> 2843371 INFO (qtp1716486702-20080) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[44]} 0 0
[junit4] 2> 2843373 INFO (qtp1716486702-20081) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[45]} 0 0
[junit4] 2> 2843375 INFO (qtp1716486702-20074) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[46]} 0 0
[junit4] 2> 2843377 INFO (qtp1716486702-20078) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[47]} 0 0
[junit4] 2> 2843379 INFO (qtp1716486702-20076) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[48]} 0 0
[junit4] 2> 2843381 INFO (qtp1716486702-20077) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[49]} 0 0
[junit4] 2> 2843383 INFO (qtp1716486702-20079) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[50]} 0 0
[junit4] 2> 2843385 INFO (qtp1716486702-20080) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[51]} 0 0
[junit4] 2> 2843387 INFO (qtp1716486702-20081) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[52]} 0 0
[junit4] 2> 2843389 INFO (qtp1716486702-20074) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[53]} 0 0
[junit4] 2> 2843391 INFO (qtp1716486702-20078) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[54]} 0 0
[junit4] 2> 2843393 INFO (qtp1716486702-20076) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[55]} 0 0
[junit4] 2> 2843394 INFO (qtp1716486702-20077) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[56]} 0 0
[junit4] 2> 2843396 INFO (qtp1716486702-20079) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[57]} 0 0
[junit4] 2> 2843398 INFO (qtp1716486702-20080) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[58]} 0 0
[junit4] 2> 2843400 INFO (qtp1716486702-20081) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[59]} 0 0
[junit4] 2> 2843402 INFO (qtp1716486702-20074) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[60]} 0 0
[junit4] 2> 2843404 INFO (qtp1716486702-20078) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[61]} 0 0
[junit4] 2> 2843407 INFO (qtp1716486702-20076) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[62]} 0 0
[junit4] 2> 2843409 INFO (qtp1716486702-20077) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[63]} 0 0
[junit4] 2> 2843411 INFO (qtp1716486702-20079) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[64]} 0 0
[junit4] 2> 2843413 INFO (qtp1716486702-20080) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[65]} 0 0
[junit4] 2> 2843415 INFO (qtp1716486702-20081) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[66]} 0 0
[junit4] 2> 2843417 INFO (qtp1716486702-20074) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[67]} 0 0
[junit4] 2> 2843418 INFO (qtp1716486702-20078) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[68]} 0 0
[junit4] 2> 2843420 INFO (qtp1716486702-20076) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[69]} 0 0
[junit4] 2> 2843422 INFO (qtp1716486702-20077) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[70]} 0 0
[junit4] 2> 2843424 INFO (qtp1716486702-20079) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[71]} 0 0
[junit4] 2> 2843426 INFO (qtp1716486702-20080) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[72]} 0 0
[junit4] 2> 2843428 INFO (qtp1716486702-20081) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[73]} 0 0
[junit4] 2> 2843430 INFO (qtp1716486702-20081) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[74]} 0 0
[junit4] 2> 2843432 INFO (qtp1716486702-20081) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[75]} 0 0
[junit4] 2> 2843435 INFO (qtp1716486702-20076) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2843436 INFO (qtp1716486702-20076) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1e56787d lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@531455cb),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1e56787d lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@531455cb),segFN=segments_2,generation=2}
[junit4] 2> 2843436 INFO (qtp1716486702-20076) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 2
[junit4] 2> 2843439 INFO (Thread-7506) [ x:collection1] o.a.s.h.SnapShooter Creating backup snapshot <not named> at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1\data\
[junit4] 2> 2843439 INFO (qtp1716486702-20076) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@2baadcdb[collection1] main
[junit4] 2> 2843439 INFO (qtp1716486702-20076) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2843439 INFO (searcherExecutor-8128-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2baadcdb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C76)))}
[junit4] 2> 2843439 INFO (qtp1716486702-20076) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 4
[junit4] 2> 2843442 INFO (qtp1716486702-20077) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 2843448 INFO (Thread-7506) [ x:collection1] o.a.s.h.SnapShooter Done creating backup snapshot: <not named> at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1\data\
[junit4] 2> 2844429 INFO (qtp1716486702-20079) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 2845415 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testBackupOnCommit
[junit4] 2> 2845416 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@6b36bda1{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 2845416 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=238330731
[junit4] 2> 2845417 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@15e5ab07
[junit4] 2> 2845417 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ x:collection1] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=76,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
[junit4] 2> 2845417 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 2845417 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 2845417 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
[junit4] 2> 2845419 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
[junit4] 2> 2845419 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 2845419 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1\data\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1\data\index;done=false>>]
[junit4] 2> 2845419 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1\data\index
[junit4] 2> 2845419 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1\data\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1\data\;done=false>>]
[junit4] 2> 2845419 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1\data\
[junit4] 2> 2845419 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29]) [ x:collection1] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5f8f4fdf{/solr,null,UNAVAILABLE}
[junit4] 2> 2845420 INFO (SUITE-TestReplicationHandlerBackup-seed#[6E9F182550A30A29]-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.TestReplicationHandlerBackup_6E9F182550A30A29-001
[junit4] 2> NOTE: test params are: codec=Lucene60, sim=ClassicSimilarity, locale=cs, timezone=Pacific/Galapagos
[junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0_66 (64-bit)/cpus=3,threads=1,free=103123088,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [UpdateRequestProcessorFactoryTest, OverseerRolesTest, ResponseLogComponentTest, OverriddenZkACLAndCredentialsProvidersTest, TestBM25SimilarityFactory, LeaderFailoverAfterPartitionTest, SortSpecParsingTest, UniqFieldsUpdateProcessorFactoryTest, TestSortingResponseWriter, TestConfigSetsAPI, AssignTest, SolrCoreCheckLockOnStartupTest, EnumFieldTest, SynonymTokenizerTest, EchoParamsTest, TestRecovery, SSLMigrationTest, DeleteShardTest, TestSQLHandler, ActionThrottleTest, TestTrie, CdcrRequestHandlerTest, CloneFieldUpdateProcessorFactoryTest, TestRandomFaceting, TestManagedSchemaFieldTypeResource, TestSolrDeletionPolicy2, TestFiltering, ShardRoutingCustomTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, CacheHeaderTest, ZkNodePropsTest, RequestHandlersTest, TestComplexPhraseQParserPlugin, DefaultValueUpdateProcessorTest, TestDynamicFieldCollectionResource, HdfsBasicDistributedZk2Test, TestFastWriter, BasicZkTest, FileBasedSpellCheckerTest, TestRuleBasedAuthorizationPlugin, TestBulkSchemaConcurrent, LoggingHandlerTest, TestConfigSetProperties, TestZkChroot, SpellingQueryConverterTest, HighlighterConfigTest, TestReload, BlockDirectoryTest, HdfsDirectoryFactoryTest, CoreAdminRequestStatusTest, TestManagedSchemaDynamicFieldResource, SolrPluginUtilsTest, TestAuthenticationFramework, TestHdfsUpdateLog, CloudMLTQParserTest, DistributedMLTComponentTest, TestNRTOpen, MultiTermTest, TestDistribDocBasedVersion, DistribDocExpirationUpdateProcessorTest, TestCollationField, TestCharFilters, SpellCheckCollatorTest, InfoHandlerTest, NotRequiredUniqueKeyTest, DeleteLastCustomShardedReplicaTest, TestFoldingMultitermQuery, FieldMutatingUpdateProcessorTest, TestSearcherReuse, HdfsUnloadDistributedZkTest, TestSimpleTrackingShardHandler, OpenCloseCoreStressTest, OutputWriterTest, DistributedQueryComponentCustomSortTest, CdcrReplicationDistributedZkTest, TestIndexSearcher, DateFieldTest, SharedFSAutoReplicaFailoverUtilsTest, TestEmbeddedSolrServerConstructors, CopyFieldTest, TestQuerySenderListener, ConfigSetsAPITest, SolrCmdDistributorTest, TestSerializedLuceneMatchVersion, CachingDirectoryFactoryTest, DateRangeFieldTest, CloudExitableDirectoryReaderTest, TestNoOpRegenerator, DistributedFacetPivotSmallTest, BinaryUpdateRequestHandlerTest, TestCloudPivotFacet, MergeStrategyTest, ForceLeaderTest, SolrCloudExampleTest, TestExclusionRuleCollectionAccess, FullHLLTest, TestCSVResponseWriter, PreAnalyzedUpdateProcessorTest, HdfsSyncSliceTest, TestReqParamsAPI, ResponseHeaderTest, TestSolrQueryParserResource, TestRTGBase, TestFileDictionaryLookup, DirectUpdateHandlerOptimizeTest, TestMinMaxOnMultiValuedField, TestSchemaSimilarityResource, RestartWhileUpdatingTest, TestSmileRequest, DistributedQueueTest, RemoteQueryErrorTest, DirectSolrConnectionTest, TestRawResponseWriter, AddSchemaFieldsUpdateProcessorFactoryTest, TestOmitPositions, TestSolrDynamicMBean, SuggestComponentTest, TestBadConfig, BigEndianAscendingWordDeserializerTest, TestCloudManagedSchemaConcurrent, TestAtomicUpdateErrorCases, TestFieldSortValues, TestRealTimeGet, RequestLoggingTest, TestShardHandlerFactory, TestLeaderInitiatedRecoveryThread, TestSolrCoreProperties, TestFieldTypeCollectionResource, AddBlockUpdateTest, SpatialHeatmapFacetsTest, RAMDirectoryFactoryTest, TestLMJelinekMercerSimilarityFactory, FileUtilsTest, FieldAnalysisRequestHandlerTest, AsyncMigrateRouteKeyTest, TestDynamicLoading, ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test, CollectionsAPIDistributedZkTest, OverseerTest, LeaderElectionIntegrationTest, TestReplicationHandler, AutoCommitTest, TestDistributedGrouping, TestFaceting, DistributedSpellCheckComponentTest, TermVectorComponentDistributedTest, ZkControllerTest, TestStressReorder, TestJoin, TestStressVersions, DistributedTermsComponentTest, TestRangeQuery, TestSolr4Spatial, SolrCoreTest, StatsComponentTest, SpellCheckComponentTest, TestGroupingSearch, QueryElevationComponentTest, PeerSyncTest, BadIndexSchemaTest, ConvertedLegacyTest, TestSort, BasicFunctionalityTest, HighlighterTest, ShowFileRequestHandlerTest, DistributedQueryElevationComponentTest, SignatureUpdateProcessorFactoryTest, SuggesterFSTTest, SuggesterTSTTest, SuggesterWFSTTest, WordBreakSolrSpellCheckerTest, TestUpdate, SortByFunctionTest, TestRemoteStreaming, DocValuesMultiTest, DistanceFunctionTest, XsltUpdateRequestHandlerTest, DebugComponentTest, TestSurroundQueryParser, DisMaxRequestHandlerTest, TestQueryUtils, TestWriterPerf, TestQueryTypes, TermsComponentTest, TestValueSourceCache, TestIndexingPerformance, TestSolrQueryParser, ReturnFieldsTest, TestAnalyzedSuggestions, CSVRequestHandlerTest, TestComponentsName, SearchHandlerTest, TestBinaryResponseWriter, TestLFUCache, PluginInfoTest, DateMathParserTest, TestSystemIdResolver, TestSuggestSpellingConverter, TestSolrJ, TestUtils, TestDocumentBuilder, SystemInfoHandlerTest, CursorPagingTest, SolrTestCaseJ4Test, TestCrossCoreJoin, TestDistributedMissingSort, TestHighlightDedupGrouping, CdcrVersionReplicationTest, CollectionReloadTest, ConcurrentDeleteAndCreateCollectionTest, ConnectionManagerTest, CustomCollectionTest, DistribCursorPagingTest, MultiThreadedOCPTest, SimpleCollectionCreateDeleteTest, TestConfigSetsAPIExclusivity, TestConfigSetsAPIZkFailure, TestLeaderElectionZkExpiry, TestMiniSolrCloudCluster, TestRebalanceLeaders, TestRequestForwarding, TestSolrCloudWithKerberosAlt, VMParamsZkACLAndCredentialsProvidersTest, HdfsBasicDistributedZkTest, HdfsChaosMonkeyNothingIsSafeTest, HdfsCollectionsAPIDistributedZkTest, HdfsThreadLeakTest, StressHdfsTest, ZkStateReaderTest, TestReplicationHandlerBackup]
[junit4] Completed [472/564 (1!)] on J1 in 4.53s, 2 tests, 1 failure <<< FAILURES!
[...truncated 314 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:784: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:728: 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:516: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1436: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:991: There were test failures: 564 suites (8 ignored), 2241 tests, 1 failure, 123 ignored (79 assumptions) [seed: 6E9F182550A30A29]
Total time: 70 minutes 54 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
Re: [JENKINS] Lucene-Solr-trunk-Windows (64bit/jdk1.8.0_66) - Build #
5459 - Failure!
Posted by Varun Thacker <va...@gmail.com>.
I'll look into this.
On Thu, Dec 10, 2015 at 6:22 AM, Policeman Jenkins Server <
jenkins@thetaphi.de> wrote:
> Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/5459/
> Java: 64bit/jdk1.8.0_66 -XX:-UseCompressedOops -XX:+UseG1GC
>
> 1 tests failed.
> FAILED: org.apache.solr.handler.TestReplicationHandlerBackup.doTestBackup
>
> Error Message:
> Failed to create backup
>
> Stack Trace:
> java.lang.AssertionError: Failed to create backup
> at
> __randomizedtesting.SeedInfo.seed([6E9F182550A30A29:2F143840771DF966]:0)
> at org.junit.Assert.fail(Assert.java:93)
> at
> org.apache.solr.handler.CheckBackupStatus.fetchStatus(CheckBackupStatus.java:51)
> at
> org.apache.solr.handler.TestReplicationHandlerBackup.doTestBackup(TestReplicationHandlerBackup.java:197)
> 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:1764)
> at
> com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
> at
> com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
> at
> com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
> 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:367)
> at
> com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
> at
> com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
> at
> com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
> at
> com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
> at
> com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
> at
> com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
> 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:40)
> at
> com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
> 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:367)
> at java.lang.Thread.run(Thread.java:745)
>
>
>
>
> Build Log:
> [...truncated 10951 lines...]
> [junit4] Suite: org.apache.solr.handler.TestReplicationHandlerBackup
> [junit4] 2> Creating dataDir:
> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\init-core-data-001
> [junit4] 2> 2840914 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] o.a.s.SolrTestCaseJ4 ###Starting doTestBackup
> [junit4] 2> 2840915 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\collection1
> [junit4] 2> 2840926 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] o.e.j.s.Server jetty-9.3.6.v20151106
> [junit4] 2> 2840928 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@209d8747
> {/solr,null,AVAILABLE}
> [junit4] 2> 2840930 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] o.e.j.s.ServerConnector Started ServerConnector@1842e833
> {HTTP/1.1,[http/1.1]}{127.0.0.1:50699}
> [junit4] 2> 2840931 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] o.e.j.s.Server Started @2836586ms
> [junit4] 2> 2840931 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\collection1\data,
> hostContext=/solr, hostPort=50699}
> [junit4] 2> 2840931 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
> sun.misc.Launcher$AppClassLoader@4e0e2f2a
> [junit4] 2> 2840931 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001'
> [junit4] 2> 2840931 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] o.a.s.c.SolrResourceLoader JNDI not configured for solr
> (NoInitialContextEx)
> [junit4] 2> 2840931 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not
> find system property or JNDI)
> [junit4] 2> 2840932 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\solr.xml
> [junit4] 2> 2840940 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] o.a.s.c.CorePropertiesLocator Config-defined core root directory:
> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.
> [junit4] 2> 2840941 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] o.a.s.c.CoreContainer New CoreContainer 55843146
> [junit4] 2> 2840941 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001]
> [junit4] 2> 2840941 WARN
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] o.a.s.c.CoreContainer Couldn't add files from
> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\lib
> to classpath:
> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\lib
> [junit4] 2> 2840941 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] 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> 2840944 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with
> params: socketTimeout=340000&connTimeout=45000&retry=true
> [junit4] 2> 2840946 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
> [junit4] 2> 2840946 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] o.a.s.l.LogWatcher Registering Log Listener [Log4j
> (org.slf4j.impl.Log4jLoggerFactory)]
> [junit4] 2> 2840946 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for
> authorization module.
> [junit4] 2> 2840946 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] o.a.s.c.CoreContainer No authentication plugin used.
> [junit4] 2> 2840948 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath
> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.
> [junit4] 2> 2840951 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1,
> config=solrconfig.xml, loadOnStartup=true, schema=schema.xml,
> configSetProperties=configsetprops.json, transient=false, dataDir=data\}
> [junit4] 2> 2840951 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] o.a.s.c.CorePropertiesLocator Found core collection1 in
> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1
> [junit4] 2> 2840951 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
> [junit4] 2> 2840952 INFO (coreLoadExecutor-8117-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\collection1'
> [junit4] 2> 2840952 INFO (coreLoadExecutor-8117-thread-1) [ ]
> o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
> [junit4] 2> 2840952 INFO (coreLoadExecutor-8117-thread-1) [ ]
> o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
> system property or JNDI)
> [junit4] 2> 2840952 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] o.a.s.s.SolrDispatchFilter
> user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1
> [junit4] 2> 2840952 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
> [junit4] 2> 2840967 INFO (coreLoadExecutor-8117-thread-1) [ ]
> o.a.s.c.SolrConfig current version of requestparams : -1
> [junit4] 2> 2840969 INFO (coreLoadExecutor-8117-thread-1) [ ]
> o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
> [junit4] 2> 2840974 INFO (coreLoadExecutor-8117-thread-1) [ ]
> o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
> [junit4] 2> 2840977 INFO (coreLoadExecutor-8117-thread-1) [ ]
> o.a.s.s.IndexSchema [collection1] Schema name=test
> [junit4] 2> 2840981 INFO (coreLoadExecutor-8117-thread-1) [ ]
> o.a.s.s.IndexSchema unique key field: id
> [junit4] 2> 2840987 INFO (coreLoadExecutor-8117-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\collection1'
> [junit4] 2> 2840987 INFO (coreLoadExecutor-8117-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1
> [junit4] 2> 2840987 INFO (coreLoadExecutor-8117-thread-1) [
> x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
> [junit4] 2> 2840987 INFO (coreLoadExecutor-8117-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\collection1],
> dataDir=[C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\]
> [junit4] 2> 2840987 INFO (coreLoadExecutor-8117-thread-1) [
> x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core:
> collection1
> [junit4] 2> 2840988 INFO (coreLoadExecutor-8117-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\
> [junit4] 2> 2840988 INFO (coreLoadExecutor-8117-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\index/
> [junit4] 2> 2840988 WARN (coreLoadExecutor-8117-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\index'
> doesn't exist. Creating new index...
> [junit4] 2> 2840988 INFO (coreLoadExecutor-8117-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\index
> [junit4] 2> 2840988 INFO (coreLoadExecutor-8117-thread-1) [
> x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
> org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
> maxMergeAtOnce=19, maxMergeAtOnceExplicit=30,
> maxMergedSegmentMB=48.056640625, floorSegmentMB=1.509765625,
> forceMergeDeletesPctAllowed=14.590512235846814, segmentsPerTier=32.0,
> maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5979371609037587
> [junit4] 2> 2840989 INFO (coreLoadExecutor-8117-thread-1) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit:
> commits: num=1
> [junit4] 2>
> commit{dir=MockDirectoryWrapper(RAMDirectory@78aa3ccf
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6b0ce9b4
> ),segFN=segments_1,generation=1}
> [junit4] 2> 2840989 INFO (coreLoadExecutor-8117-thread-1) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
> [junit4] 2> 2840989 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\
> [junit4] 2> 2840990 INFO (coreLoadExecutor-8117-thread-1) [
> x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as
> default, creating implicit default
> [junit4] 2> 2840996 INFO (coreLoadExecutor-8117-thread-1) [
> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
> [junit4] 2> 2840997 INFO (coreLoadExecutor-8117-thread-1) [
> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
> [junit4] 2> 2840998 INFO (coreLoadExecutor-8117-thread-1) [
> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
> [junit4] 2> 2840998 INFO (coreLoadExecutor-8117-thread-1) [
> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
> [junit4] 2> 2840999 INFO (coreLoadExecutor-8117-thread-1) [
> x:collection1] o.a.s.c.RequestHandlers Registered paths:
> /admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
> [junit4] 2> 2841000 INFO (coreLoadExecutor-8117-thread-1) [
> x:collection1] o.a.s.c.SolrCore Using default statsCache cache:
> org.apache.solr.search.stats.LocalStatsCache
> [junit4] 2> 2841000 INFO (coreLoadExecutor-8117-thread-1) [
> x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
> [junit4] 2> 2841000 INFO (coreLoadExecutor-8117-thread-1) [
> x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
> [junit4] 2> 2841000 INFO (coreLoadExecutor-8117-thread-1) [
> x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
> org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
> maxMergeAtOnce=13, maxMergeAtOnceExplicit=22,
> maxMergedSegmentMB=45.7578125, floorSegmentMB=0.48046875,
> forceMergeDeletesPctAllowed=14.347045572391076, segmentsPerTier=37.0,
> maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
> [junit4] 2> 2841000 INFO (coreLoadExecutor-8117-thread-1) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit:
> commits: num=1
> [junit4] 2>
> commit{dir=MockDirectoryWrapper(RAMDirectory@78aa3ccf
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6b0ce9b4
> ),segFN=segments_1,generation=1}
> [junit4] 2> 2841000 INFO (coreLoadExecutor-8117-thread-1) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
> [junit4] 2> 2841001 INFO (coreLoadExecutor-8117-thread-1) [
> x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@31664577[collection1]
> main
> [junit4] 2> 2841002 INFO (coreLoadExecutor-8117-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\collection1\conf
> [junit4] 2> 2841002 INFO (coreLoadExecutor-8117-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\collection1\conf}
> [junit4] 2> 2841002 INFO (coreLoadExecutor-8117-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\collection1\conf
> [junit4] 2> 2841002 INFO (coreLoadExecutor-8117-thread-1) [
> x:collection1] o.a.s.r.RestManager Initializing 0 registered
> ManagedResources
> [junit4] 2> 2841003 INFO (coreLoadExecutor-8117-thread-1) [
> x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following
> config files: schema-replication2.xml:schema.xml
> [junit4] 2> 2841003 INFO (coreLoadExecutor-8117-thread-1) [
> x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for
> 10000
> [junit4] 2> 2841003 INFO
> (searcherExecutor-8118-thread-1-processing-x:collection1) [
> x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher
> Searcher@31664577[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader())}
> [junit4] 2> 2841003 INFO (coreLoadExecutor-8117-thread-1) [
> x:collection1] o.a.s.c.CoreContainer registering core: collection1
> [junit4] 2> 2841503 INFO (qtp361078011-20052) [ x:collection1]
> o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
> [junit4] 2> 2841503 INFO (qtp361078011-20052) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {deleteByQuery=*:*} 0 0
> [junit4] 2> 2841506 INFO (qtp361078011-20053) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[0]} 0 0
> [junit4] 2> 2841508 INFO (qtp361078011-20054) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[1]} 0 0
> [junit4] 2> 2841510 INFO (qtp361078011-20055) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[2]} 0 0
> [junit4] 2> 2841513 INFO (qtp361078011-20056) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[3]} 0 0
> [junit4] 2> 2841515 INFO (qtp361078011-20057) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[4]} 0 0
> [junit4] 2> 2841517 INFO (qtp361078011-20050) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[5]} 0 0
> [junit4] 2> 2841519 INFO (qtp361078011-20052) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[6]} 0 0
> [junit4] 2> 2841521 INFO (qtp361078011-20053) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[7]} 0 0
> [junit4] 2> 2841523 INFO (qtp361078011-20054) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[8]} 0 0
> [junit4] 2> 2841525 INFO (qtp361078011-20055) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[9]} 0 0
> [junit4] 2> 2841528 INFO (qtp361078011-20056) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[10]} 0 0
> [junit4] 2> 2841530 INFO (qtp361078011-20057) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[11]} 0 0
> [junit4] 2> 2841532 INFO (qtp361078011-20050) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[12]} 0 0
> [junit4] 2> 2841534 INFO (qtp361078011-20052) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[13]} 0 0
> [junit4] 2> 2841537 INFO (qtp361078011-20053) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[14]} 0 0
> [junit4] 2> 2841539 INFO (qtp361078011-20053) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[15]} 0 0
> [junit4] 2> 2841541 INFO (qtp361078011-20055) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[16]} 0 0
> [junit4] 2> 2841544 INFO (qtp361078011-20056) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[17]} 0 0
> [junit4] 2> 2841546 INFO (qtp361078011-20057) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[18]} 0 0
> [junit4] 2> 2841548 INFO (qtp361078011-20050) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[19]} 0 0
> [junit4] 2> 2841550 INFO (qtp361078011-20052) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[20]} 0 0
> [junit4] 2> 2841552 INFO (qtp361078011-20054) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[21]} 0 0
> [junit4] 2> 2841554 INFO (qtp361078011-20053) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[22]} 0 0
> [junit4] 2> 2841556 INFO (qtp361078011-20053) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[23]} 0 0
> [junit4] 2> 2841559 INFO (qtp361078011-20053) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[24]} 0 0
> [junit4] 2> 2841561 INFO (qtp361078011-20057) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[25]} 0 0
> [junit4] 2> 2841563 INFO (qtp361078011-20050) [ x:collection1]
> o.a.s.u.DirectUpdateHandler2 start
> commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
> [junit4] 2> 2841565 INFO (qtp361078011-20050) [ x:collection1]
> o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
> [junit4] 2>
> commit{dir=MockDirectoryWrapper(RAMDirectory@78aa3ccf
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6b0ce9b4
> ),segFN=segments_1,generation=1}
> [junit4] 2>
> commit{dir=MockDirectoryWrapper(RAMDirectory@78aa3ccf
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6b0ce9b4
> ),segFN=segments_2,generation=2}
> [junit4] 2> 2841567 INFO (qtp361078011-20050) [ x:collection1]
> o.a.s.c.SolrDeletionPolicy newest commit generation = 2
> [junit4] 2> 2841569 INFO (Thread-7489) [ x:collection1]
> o.a.s.h.SnapShooter Creating backup snapshot <not named> at
> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\
> [junit4] 2> 2841570 INFO (qtp361078011-20050) [ x:collection1]
> o.a.s.s.SolrIndexSearcher Opening Searcher@159deca3[collection1] main
> [junit4] 2> 2841570 INFO
> (searcherExecutor-8118-thread-1-processing-x:collection1) [
> x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher
> Searcher@159deca3[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C26)))}
> [junit4] 2> 2841570 INFO (qtp361078011-20050) [ x:collection1]
> o.a.s.u.DirectUpdateHandler2 end_commit_flush
> [junit4] 2> 2841570 INFO (qtp361078011-20050) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
> {commit=} 0 6
> [junit4] 2> 2841578 INFO (qtp361078011-20054) [ x:collection1]
> o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
> params={command=backup} status=0 QTime=2
> [junit4] 2> 2841580 INFO (Thread-7490) [ x:collection1]
> o.a.s.h.SnapShooter Creating backup snapshot <not named> at
> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\
> [junit4] 2> 2841591 INFO (Thread-7490) [ x:collection1]
> o.a.s.h.SnapShooter Done creating backup snapshot: <not named> at
> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\
> [junit4] 2> 2841594 INFO (qtp361078011-20055) [ x:collection1]
> o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
> params={command=details} status=0 QTime=8
> [junit4] 2> 2841626 ERROR (Thread-7489) [ x:collection1]
> o.a.s.h.SnapShooter Exception while creating snapshot
> [junit4] 2> java.nio.file.NoSuchFileException:
> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\collection1\data\snapshot.20151209184814469\_0.fdx
> [junit4] 2> at
> sun.nio.fs.WindowsException.translateToIOException(WindowsException.java:79)
> [junit4] 2> at
> sun.nio.fs.WindowsException.rethrowAsIOException(WindowsException.java:97)
> [junit4] 2> at
> sun.nio.fs.WindowsException.rethrowAsIOException(WindowsException.java:102)
> [junit4] 2> at
> sun.nio.fs.WindowsFileSystemProvider.newByteChannel(WindowsFileSystemProvider.java:230)
> [junit4] 2> at
> java.nio.file.spi.FileSystemProvider.newOutputStream(FileSystemProvider.java:434)
> [junit4] 2> at
> java.nio.file.Files.newOutputStream(Files.java:216)
> [junit4] 2> at
> org.apache.lucene.store.FSDirectory$FSIndexOutput.<init>(FSDirectory.java:301)
> [junit4] 2> at
> org.apache.lucene.store.FSDirectory$FSIndexOutput.<init>(FSDirectory.java:297)
> [junit4] 2> at
> org.apache.lucene.store.FSDirectory.createOutput(FSDirectory.java:232)
> [junit4] 2> at
> org.apache.lucene.store.Directory.copyFrom(Directory.java:155)
> [junit4] 2> at
> org.apache.solr.handler.SnapShooter.copyFiles(SnapShooter.java:203)
> [junit4] 2> at
> org.apache.solr.handler.SnapShooter.createSnapshot(SnapShooter.java:136)
> [junit4] 2> at
> org.apache.solr.handler.SnapShooter$1.run(SnapShooter.java:85)
> [junit4] 2> 2842648 INFO (qtp361078011-20055) [ x:collection1]
> o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
> params={command=backup} status=0 QTime=1
> [junit4] 2> 2842648 INFO (Thread-7491) [ x:collection1]
> o.a.s.h.SnapShooter Creating backup snapshot <not named> at
> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\
> [junit4] 2> 2842650 INFO (qtp361078011-20053) [ x:collection1]
> o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
> params={command=details} status=0 QTime=0
> [junit4] 2> 2842651 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] o.a.s.SolrTestCaseJ4 ###Ending doTestBackup
> [junit4] 2> 2842652 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] o.e.j.s.ServerConnector Stopped ServerConnector@1842e833
> {HTTP/1.1,[http/1.1]}{127.0.0.1:0}
> [junit4] 2> 2842652 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=55843146
> [junit4] 2> 2842652 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
> org.apache.solr.core.SolrCore@3fa1e35a
> [junit4] 2> 2842652 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> x:collection1] o.a.s.u.DirectUpdateHandler2 closing
> DirectUpdateHandler2{commits=1,autocommits=0,soft
> autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=26,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
> [junit4] 2> 2842652 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
> [junit4] 2> 2842652 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has
> reached 0 - closing IndexWriter
> [junit4] 2> 2842652 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with
> IndexWriterCloser
> [junit4] 2> 2842652 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on
> request.
> [junit4] 2> 2842652 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> x:collection1] o.a.s.c.CachingDirectoryFactory Closing
> MockDirectoryFactory - 2 directories currently being tracked
> [junit4] 2> 2842658 INFO (Thread-7491) [ x:collection1]
> o.a.s.h.SnapShooter Done creating backup snapshot: <not named> at
> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\
> [junit4] 2> 2842751 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\
> [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\;done=false>>]
> [junit4] 2> 2842751 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\
> [junit4] 2> 2842751 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\index
> [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\index;done=false>>]
> [junit4] 2> 2842751 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-001\.\collection1\data\index
> [junit4] 2> 2842751 INFO
> (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[6E9F182550A30A29]) [
> x:collection1] o.e.j.s.h.ContextHandler Stopped
> o.e.j.s.ServletContextHandler@209d8747{/solr,null,UNAVAILABLE}
> [junit4] 2> NOTE: reproduce with: ant test
> -Dtestcase=TestReplicationHandlerBackup -Dtests.method=doTestBackup
> -Dtests.seed=6E9F182550A30A29 -Dtests.slow=true -Dtests.locale=cs
> -Dtests.timezone=Pacific/Galapagos -Dtests.asserts=true
> -Dtests.file.encoding=ISO-8859-1
> [junit4] FAILURE 1.84s J1 | TestReplicationHandlerBackup.doTestBackup
> <<<
> [junit4] > Throwable #1: java.lang.AssertionError: Failed to create
> backup
> [junit4] > at
> __randomizedtesting.SeedInfo.seed([6E9F182550A30A29:2F143840771DF966]:0)
> [junit4] > at
> org.apache.solr.handler.CheckBackupStatus.fetchStatus(CheckBackupStatus.java:51)
> [junit4] > at
> org.apache.solr.handler.TestReplicationHandlerBackup.doTestBackup(TestReplicationHandlerBackup.java:197)
> [junit4] > at java.lang.Thread.run(Thread.java:745)
> [junit4] 2> 2842757 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] o.a.s.SolrTestCaseJ4 ###Starting testBackupOnCommit
> [junit4] 2> 2842763 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\collection1
> [junit4] 2> 2842771 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] o.e.j.s.Server jetty-9.3.6.v20151106
> [junit4] 2> 2842772 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] o.e.j.s.h.ContextHandler Started
> o.e.j.s.ServletContextHandler@5f8f4fdf{/solr,null,AVAILABLE}
> [junit4] 2> 2842773 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] o.e.j.s.ServerConnector Started ServerConnector@6b36bda1
> {HTTP/1.1,[http/1.1]}{127.0.0.1:50719}
> [junit4] 2> 2842773 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] o.e.j.s.Server Started @2838325ms
> [junit4] 2> 2842773 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\collection1\data,
> hostContext=/solr, hostPort=50719}
> [junit4] 2> 2842773 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
> sun.misc.Launcher$AppClassLoader@4e0e2f2a
> [junit4] 2> 2842773 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002'
> [junit4] 2> 2842774 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr
> (NoInitialContextEx)
> [junit4] 2> 2842774 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not
> find system property or JNDI)
> [junit4] 2> 2842774 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\solr.xml
> [junit4] 2> 2842777 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory:
> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.
> [junit4] 2> 2842777 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] o.a.s.c.CoreContainer New CoreContainer 238330731
> [junit4] 2> 2842777 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002]
> [junit4] 2> 2842777 WARN
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] o.a.s.c.CoreContainer Couldn't add files from
> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\lib
> to classpath:
> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\lib
> [junit4] 2> 2842778 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] 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> 2842778 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client
> with params: socketTimeout=340000&connTimeout=45000&retry=true
> [junit4] 2> 2842779 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
> [junit4] 2> 2842779 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j
> (org.slf4j.impl.Log4jLoggerFactory)]
> [junit4] 2> 2842779 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup
> for authorization module.
> [junit4] 2> 2842779 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] o.a.s.c.CoreContainer No authentication plugin used.
> [junit4] 2> 2842780 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] o.a.s.c.CorePropertiesLocator Looking for core definitions
> underneath
> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.
> [junit4] 2> 2842782 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1,
> config=solrconfig.xml, loadOnStartup=true, schema=schema.xml,
> configSetProperties=configsetprops.json, transient=false, dataDir=data\}
> [junit4] 2> 2842782 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] o.a.s.c.CorePropertiesLocator Found core collection1 in
> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1
> [junit4] 2> 2842783 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
> [junit4] 2> 2842783 INFO (coreLoadExecutor-8127-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\collection1'
> [junit4] 2> 2842783 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] o.a.s.s.SolrDispatchFilter
> user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1
> [junit4] 2> 2842784 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
> [junit4] 2> 2842784 INFO (coreLoadExecutor-8127-thread-1) [ ]
> o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
> [junit4] 2> 2842784 INFO (coreLoadExecutor-8127-thread-1) [ ]
> o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
> system property or JNDI)
> [junit4] 2> 2842790 INFO (coreLoadExecutor-8127-thread-1) [ ]
> o.a.s.c.SolrConfig current version of requestparams : -1
> [junit4] 2> 2842793 INFO (coreLoadExecutor-8127-thread-1) [ ]
> o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
> [junit4] 2> 2842797 INFO (coreLoadExecutor-8127-thread-1) [ ]
> o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
> [junit4] 2> 2842800 INFO (coreLoadExecutor-8127-thread-1) [ ]
> o.a.s.s.IndexSchema [collection1] Schema name=test
> [junit4] 2> 2842801 INFO (coreLoadExecutor-8127-thread-1) [ ]
> o.a.s.s.IndexSchema unique key field: id
> [junit4] 2> 2842802 INFO (coreLoadExecutor-8127-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\collection1'
> [junit4] 2> 2842802 INFO (coreLoadExecutor-8127-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1
> [junit4] 2> 2842803 INFO (coreLoadExecutor-8127-thread-1) [
> x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
> [junit4] 2> 2842803 INFO (coreLoadExecutor-8127-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\collection1],
> dataDir=[C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1\data\]
> [junit4] 2> 2842803 INFO (coreLoadExecutor-8127-thread-1) [
> x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core:
> collection1
> [junit4] 2> 2842804 INFO (coreLoadExecutor-8127-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1\data\
> [junit4] 2> 2842804 INFO (coreLoadExecutor-8127-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1\data\index/
> [junit4] 2> 2842804 WARN (coreLoadExecutor-8127-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1\data\index'
> doesn't exist. Creating new index...
> [junit4] 2> 2842804 INFO (coreLoadExecutor-8127-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1\data\index
> [junit4] 2> 2842804 INFO (coreLoadExecutor-8127-thread-1) [
> x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
> org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
> maxMergeAtOnce=19, maxMergeAtOnceExplicit=30,
> maxMergedSegmentMB=48.056640625, floorSegmentMB=1.509765625,
> forceMergeDeletesPctAllowed=14.590512235846814, segmentsPerTier=32.0,
> maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5979371609037587
> [junit4] 2> 2842804 INFO (coreLoadExecutor-8127-thread-1) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit:
> commits: num=1
> [junit4] 2>
> commit{dir=MockDirectoryWrapper(RAMDirectory@1e56787d
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@531455cb
> ),segFN=segments_1,generation=1}
> [junit4] 2> 2842804 INFO (coreLoadExecutor-8127-thread-1) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
> [junit4] 2> 2842805 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1\data\
> [junit4] 2> 2842806 INFO (coreLoadExecutor-8127-thread-1) [
> x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as
> default, creating implicit default
> [junit4] 2> 2842807 INFO (coreLoadExecutor-8127-thread-1) [
> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
> [junit4] 2> 2842808 INFO (coreLoadExecutor-8127-thread-1) [
> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
> [junit4] 2> 2842809 INFO (coreLoadExecutor-8127-thread-1) [
> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
> [junit4] 2> 2842810 INFO (coreLoadExecutor-8127-thread-1) [
> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
> [junit4] 2> 2842810 INFO (coreLoadExecutor-8127-thread-1) [
> x:collection1] o.a.s.c.RequestHandlers Registered paths:
> /admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
> [junit4] 2> 2842811 INFO (coreLoadExecutor-8127-thread-1) [
> x:collection1] o.a.s.c.SolrCore Using default statsCache cache:
> org.apache.solr.search.stats.LocalStatsCache
> [junit4] 2> 2842811 INFO (coreLoadExecutor-8127-thread-1) [
> x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
> [junit4] 2> 2842811 INFO (coreLoadExecutor-8127-thread-1) [
> x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
> [junit4] 2> 2842811 INFO (coreLoadExecutor-8127-thread-1) [
> x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
> org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
> maxMergeAtOnce=13, maxMergeAtOnceExplicit=22,
> maxMergedSegmentMB=45.7578125, floorSegmentMB=0.48046875,
> forceMergeDeletesPctAllowed=14.347045572391076, segmentsPerTier=37.0,
> maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
> [junit4] 2> 2842812 INFO (coreLoadExecutor-8127-thread-1) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit:
> commits: num=1
> [junit4] 2>
> commit{dir=MockDirectoryWrapper(RAMDirectory@1e56787d
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@531455cb
> ),segFN=segments_1,generation=1}
> [junit4] 2> 2842812 INFO (coreLoadExecutor-8127-thread-1) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
> [junit4] 2> 2842812 INFO (coreLoadExecutor-8127-thread-1) [
> x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@594587a3[collection1]
> main
> [junit4] 2> 2842812 INFO (coreLoadExecutor-8127-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\collection1\conf
> [junit4] 2> 2842812 INFO (coreLoadExecutor-8127-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\collection1\conf}
> [junit4] 2> 2842812 INFO (coreLoadExecutor-8127-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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\collection1\conf
> [junit4] 2> 2842813 INFO (coreLoadExecutor-8127-thread-1) [
> x:collection1] o.a.s.r.RestManager Initializing 0 registered
> ManagedResources
> [junit4] 2> 2842813 INFO (coreLoadExecutor-8127-thread-1) [
> x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following
> config files: schema-replication2.xml:schema.xml
> [junit4] 2> 2842813 INFO (coreLoadExecutor-8127-thread-1) [
> x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for
> 10000
> [junit4] 2> 2842813 INFO (coreLoadExecutor-8127-thread-1) [
> x:collection1] o.a.s.c.CoreContainer registering core: collection1
> [junit4] 2> 2842813 INFO
> (searcherExecutor-8128-thread-1-processing-x:collection1) [
> x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher
> Searcher@594587a3[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader())}
> [junit4] 2> 2843280 INFO (qtp1716486702-20076) [ x:collection1]
> o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
> [junit4] 2> 2843280 INFO (qtp1716486702-20076) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {deleteByQuery=*:*} 0 0
> [junit4] 2> 2843282 INFO (qtp1716486702-20077) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[0]} 0 0
> [junit4] 2> 2843285 INFO (qtp1716486702-20078) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[1]} 0 0
> [junit4] 2> 2843287 INFO (qtp1716486702-20079) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[2]} 0 0
> [junit4] 2> 2843289 INFO (qtp1716486702-20080) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[3]} 0 0
> [junit4] 2> 2843291 INFO (qtp1716486702-20081) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[4]} 0 0
> [junit4] 2> 2843293 INFO (qtp1716486702-20074) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[5]} 0 0
> [junit4] 2> 2843295 INFO (qtp1716486702-20076) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[6]} 0 0
> [junit4] 2> 2843296 INFO (qtp1716486702-20077) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[7]} 0 0
> [junit4] 2> 2843298 INFO (qtp1716486702-20078) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[8]} 0 0
> [junit4] 2> 2843300 INFO (qtp1716486702-20079) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[9]} 0 0
> [junit4] 2> 2843302 INFO (qtp1716486702-20080) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[10]} 0 0
> [junit4] 2> 2843304 INFO (qtp1716486702-20081) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[11]} 0 0
> [junit4] 2> 2843306 INFO (qtp1716486702-20074) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[12]} 0 0
> [junit4] 2> 2843308 INFO (qtp1716486702-20076) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[13]} 0 0
> [junit4] 2> 2843310 INFO (qtp1716486702-20077) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[14]} 0 0
> [junit4] 2> 2843312 INFO (qtp1716486702-20078) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[15]} 0 0
> [junit4] 2> 2843314 INFO (qtp1716486702-20079) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[16]} 0 0
> [junit4] 2> 2843316 INFO (qtp1716486702-20080) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[17]} 0 0
> [junit4] 2> 2843318 INFO (qtp1716486702-20081) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[18]} 0 0
> [junit4] 2> 2843319 INFO (qtp1716486702-20074) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[19]} 0 0
> [junit4] 2> 2843321 INFO (qtp1716486702-20076) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[20]} 0 0
> [junit4] 2> 2843323 INFO (qtp1716486702-20077) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[21]} 0 0
> [junit4] 2> 2843326 INFO (qtp1716486702-20078) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[22]} 0 0
> [junit4] 2> 2843328 INFO (qtp1716486702-20079) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[23]} 0 0
> [junit4] 2> 2843330 INFO (qtp1716486702-20080) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[24]} 0 0
> [junit4] 2> 2843332 INFO (qtp1716486702-20081) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[25]} 0 0
> [junit4] 2> 2843334 INFO (qtp1716486702-20074) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[26]} 0 0
> [junit4] 2> 2843336 INFO (qtp1716486702-20076) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[27]} 0 0
> [junit4] 2> 2843338 INFO (qtp1716486702-20077) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[28]} 0 0
> [junit4] 2> 2843340 INFO (qtp1716486702-20078) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[29]} 0 0
> [junit4] 2> 2843343 INFO (qtp1716486702-20078) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[30]} 0 0
> [junit4] 2> 2843345 INFO (qtp1716486702-20078) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[31]} 0 0
> [junit4] 2> 2843347 INFO (qtp1716486702-20078) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[32]} 0 0
> [junit4] 2> 2843349 INFO (qtp1716486702-20078) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[33]} 0 0
> [junit4] 2> 2843351 INFO (qtp1716486702-20078) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[34]} 0 0
> [junit4] 2> 2843353 INFO (qtp1716486702-20077) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[35]} 0 0
> [junit4] 2> 2843355 INFO (qtp1716486702-20079) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[36]} 0 0
> [junit4] 2> 2843357 INFO (qtp1716486702-20080) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[37]} 0 0
> [junit4] 2> 2843359 INFO (qtp1716486702-20081) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[38]} 0 0
> [junit4] 2> 2843361 INFO (qtp1716486702-20074) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[39]} 0 0
> [junit4] 2> 2843364 INFO (qtp1716486702-20076) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[40]} 0 0
> [junit4] 2> 2843366 INFO (qtp1716486702-20076) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[41]} 0 0
> [junit4] 2> 2843368 INFO (qtp1716486702-20077) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[42]} 0 0
> [junit4] 2> 2843369 INFO (qtp1716486702-20079) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[43]} 0 0
> [junit4] 2> 2843371 INFO (qtp1716486702-20080) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[44]} 0 0
> [junit4] 2> 2843373 INFO (qtp1716486702-20081) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[45]} 0 0
> [junit4] 2> 2843375 INFO (qtp1716486702-20074) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[46]} 0 0
> [junit4] 2> 2843377 INFO (qtp1716486702-20078) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[47]} 0 0
> [junit4] 2> 2843379 INFO (qtp1716486702-20076) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[48]} 0 0
> [junit4] 2> 2843381 INFO (qtp1716486702-20077) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[49]} 0 0
> [junit4] 2> 2843383 INFO (qtp1716486702-20079) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[50]} 0 0
> [junit4] 2> 2843385 INFO (qtp1716486702-20080) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[51]} 0 0
> [junit4] 2> 2843387 INFO (qtp1716486702-20081) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[52]} 0 0
> [junit4] 2> 2843389 INFO (qtp1716486702-20074) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[53]} 0 0
> [junit4] 2> 2843391 INFO (qtp1716486702-20078) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[54]} 0 0
> [junit4] 2> 2843393 INFO (qtp1716486702-20076) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[55]} 0 0
> [junit4] 2> 2843394 INFO (qtp1716486702-20077) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[56]} 0 0
> [junit4] 2> 2843396 INFO (qtp1716486702-20079) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[57]} 0 0
> [junit4] 2> 2843398 INFO (qtp1716486702-20080) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[58]} 0 0
> [junit4] 2> 2843400 INFO (qtp1716486702-20081) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[59]} 0 0
> [junit4] 2> 2843402 INFO (qtp1716486702-20074) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[60]} 0 0
> [junit4] 2> 2843404 INFO (qtp1716486702-20078) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[61]} 0 0
> [junit4] 2> 2843407 INFO (qtp1716486702-20076) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[62]} 0 0
> [junit4] 2> 2843409 INFO (qtp1716486702-20077) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[63]} 0 0
> [junit4] 2> 2843411 INFO (qtp1716486702-20079) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[64]} 0 0
> [junit4] 2> 2843413 INFO (qtp1716486702-20080) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[65]} 0 0
> [junit4] 2> 2843415 INFO (qtp1716486702-20081) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[66]} 0 0
> [junit4] 2> 2843417 INFO (qtp1716486702-20074) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[67]} 0 0
> [junit4] 2> 2843418 INFO (qtp1716486702-20078) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[68]} 0 0
> [junit4] 2> 2843420 INFO (qtp1716486702-20076) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[69]} 0 0
> [junit4] 2> 2843422 INFO (qtp1716486702-20077) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[70]} 0 0
> [junit4] 2> 2843424 INFO (qtp1716486702-20079) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[71]} 0 0
> [junit4] 2> 2843426 INFO (qtp1716486702-20080) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[72]} 0 0
> [junit4] 2> 2843428 INFO (qtp1716486702-20081) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[73]} 0 0
> [junit4] 2> 2843430 INFO (qtp1716486702-20081) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[74]} 0 0
> [junit4] 2> 2843432 INFO (qtp1716486702-20081) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={wt=javabin&version=2} {add=[75]} 0 0
> [junit4] 2> 2843435 INFO (qtp1716486702-20076) [ x:collection1]
> o.a.s.u.DirectUpdateHandler2 start
> commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
> [junit4] 2> 2843436 INFO (qtp1716486702-20076) [ x:collection1]
> o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
> [junit4] 2>
> commit{dir=MockDirectoryWrapper(RAMDirectory@1e56787d
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@531455cb
> ),segFN=segments_1,generation=1}
> [junit4] 2>
> commit{dir=MockDirectoryWrapper(RAMDirectory@1e56787d
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@531455cb
> ),segFN=segments_2,generation=2}
> [junit4] 2> 2843436 INFO (qtp1716486702-20076) [ x:collection1]
> o.a.s.c.SolrDeletionPolicy newest commit generation = 2
> [junit4] 2> 2843439 INFO (Thread-7506) [ x:collection1]
> o.a.s.h.SnapShooter Creating backup snapshot <not named> at
> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1\data\
> [junit4] 2> 2843439 INFO (qtp1716486702-20076) [ x:collection1]
> o.a.s.s.SolrIndexSearcher Opening Searcher@2baadcdb[collection1] main
> [junit4] 2> 2843439 INFO (qtp1716486702-20076) [ x:collection1]
> o.a.s.u.DirectUpdateHandler2 end_commit_flush
> [junit4] 2> 2843439 INFO
> (searcherExecutor-8128-thread-1-processing-x:collection1) [
> x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher
> Searcher@2baadcdb[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C76)))}
> [junit4] 2> 2843439 INFO (qtp1716486702-20076) [ x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
> params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
> {commit=} 0 4
> [junit4] 2> 2843442 INFO (qtp1716486702-20077) [ x:collection1]
> o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
> params={command=details} status=0 QTime=0
> [junit4] 2> 2843448 INFO (Thread-7506) [ x:collection1]
> o.a.s.h.SnapShooter Done creating backup snapshot: <not named> at
> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1\data\
> [junit4] 2> 2844429 INFO (qtp1716486702-20079) [ x:collection1]
> o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
> params={command=details} status=0 QTime=0
> [junit4] 2> 2845415 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] o.a.s.SolrTestCaseJ4 ###Ending testBackupOnCommit
> [junit4] 2> 2845416 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] o.e.j.s.ServerConnector Stopped ServerConnector@6b36bda1
> {HTTP/1.1,[http/1.1]}{127.0.0.1:0}
> [junit4] 2> 2845416 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=238330731
> [junit4] 2> 2845417 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
> org.apache.solr.core.SolrCore@15e5ab07
> [junit4] 2> 2845417 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ x:collection1] o.a.s.u.DirectUpdateHandler2 closing
> DirectUpdateHandler2{commits=1,autocommits=0,soft
> autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=76,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
> [junit4] 2> 2845417 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
> [junit4] 2> 2845417 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count
> has reached 0 - closing IndexWriter
> [junit4] 2> 2845417 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with
> IndexWriterCloser
> [junit4] 2> 2845419 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on
> request.
> [junit4] 2> 2845419 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing
> MockDirectoryFactory - 2 directories currently being tracked
> [junit4] 2> 2845419 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1\data\index
> [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1\data\index;done=false>>]
> [junit4] 2> 2845419 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1\data\index
> [junit4] 2> 2845419 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1\data\
> [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1\data\;done=false>>]
> [junit4] 2> 2845419 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ 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.TestReplicationHandlerBackup_6E9F182550A30A29-001\solr-instance-002\.\collection1\data\
> [junit4] 2> 2845419 INFO
> (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[6E9F182550A30A29])
> [ x:collection1] o.e.j.s.h.ContextHandler Stopped
> o.e.j.s.ServletContextHandler@5f8f4fdf{/solr,null,UNAVAILABLE}
> [junit4] 2> 2845420 INFO
> (SUITE-TestReplicationHandlerBackup-seed#[6E9F182550A30A29]-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.TestReplicationHandlerBackup_6E9F182550A30A29-001
> [junit4] 2> NOTE: test params are: codec=Lucene60,
> sim=ClassicSimilarity, locale=cs, timezone=Pacific/Galapagos
> [junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0_66
> (64-bit)/cpus=3,threads=1,free=103123088,total=536870912
> [junit4] 2> NOTE: All tests run in this JVM:
> [UpdateRequestProcessorFactoryTest, OverseerRolesTest,
> ResponseLogComponentTest, OverriddenZkACLAndCredentialsProvidersTest,
> TestBM25SimilarityFactory, LeaderFailoverAfterPartitionTest,
> SortSpecParsingTest, UniqFieldsUpdateProcessorFactoryTest,
> TestSortingResponseWriter, TestConfigSetsAPI, AssignTest,
> SolrCoreCheckLockOnStartupTest, EnumFieldTest, SynonymTokenizerTest,
> EchoParamsTest, TestRecovery, SSLMigrationTest, DeleteShardTest,
> TestSQLHandler, ActionThrottleTest, TestTrie, CdcrRequestHandlerTest,
> CloneFieldUpdateProcessorFactoryTest, TestRandomFaceting,
> TestManagedSchemaFieldTypeResource, TestSolrDeletionPolicy2, TestFiltering,
> ShardRoutingCustomTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest,
> CacheHeaderTest, ZkNodePropsTest, RequestHandlersTest,
> TestComplexPhraseQParserPlugin, DefaultValueUpdateProcessorTest,
> TestDynamicFieldCollectionResource, HdfsBasicDistributedZk2Test,
> TestFastWriter, BasicZkTest, FileBasedSpellCheckerTest,
> TestRuleBasedAuthorizationPlugin, TestBulkSchemaConcurrent,
> LoggingHandlerTest, TestConfigSetProperties, TestZkChroot,
> SpellingQueryConverterTest, HighlighterConfigTest, TestReload,
> BlockDirectoryTest, HdfsDirectoryFactoryTest, CoreAdminRequestStatusTest,
> TestManagedSchemaDynamicFieldResource, SolrPluginUtilsTest,
> TestAuthenticationFramework, TestHdfsUpdateLog, CloudMLTQParserTest,
> DistributedMLTComponentTest, TestNRTOpen, MultiTermTest,
> TestDistribDocBasedVersion, DistribDocExpirationUpdateProcessorTest,
> TestCollationField, TestCharFilters, SpellCheckCollatorTest,
> InfoHandlerTest, NotRequiredUniqueKeyTest,
> DeleteLastCustomShardedReplicaTest, TestFoldingMultitermQuery,
> FieldMutatingUpdateProcessorTest, TestSearcherReuse,
> HdfsUnloadDistributedZkTest, TestSimpleTrackingShardHandler,
> OpenCloseCoreStressTest, OutputWriterTest,
> DistributedQueryComponentCustomSortTest, CdcrReplicationDistributedZkTest,
> TestIndexSearcher, DateFieldTest, SharedFSAutoReplicaFailoverUtilsTest,
> TestEmbeddedSolrServerConstructors, CopyFieldTest, TestQuerySenderListener,
> ConfigSetsAPITest, SolrCmdDistributorTest,
> TestSerializedLuceneMatchVersion, CachingDirectoryFactoryTest,
> DateRangeFieldTest, CloudExitableDirectoryReaderTest, TestNoOpRegenerator,
> DistributedFacetPivotSmallTest, BinaryUpdateRequestHandlerTest,
> TestCloudPivotFacet, MergeStrategyTest, ForceLeaderTest,
> SolrCloudExampleTest, TestExclusionRuleCollectionAccess, FullHLLTest,
> TestCSVResponseWriter, PreAnalyzedUpdateProcessorTest, HdfsSyncSliceTest,
> TestReqParamsAPI, ResponseHeaderTest, TestSolrQueryParserResource,
> TestRTGBase, TestFileDictionaryLookup, DirectUpdateHandlerOptimizeTest,
> TestMinMaxOnMultiValuedField, TestSchemaSimilarityResource,
> RestartWhileUpdatingTest, TestSmileRequest, DistributedQueueTest,
> RemoteQueryErrorTest, DirectSolrConnectionTest, TestRawResponseWriter,
> AddSchemaFieldsUpdateProcessorFactoryTest, TestOmitPositions,
> TestSolrDynamicMBean, SuggestComponentTest, TestBadConfig,
> BigEndianAscendingWordDeserializerTest, TestCloudManagedSchemaConcurrent,
> TestAtomicUpdateErrorCases, TestFieldSortValues, TestRealTimeGet,
> RequestLoggingTest, TestShardHandlerFactory,
> TestLeaderInitiatedRecoveryThread, TestSolrCoreProperties,
> TestFieldTypeCollectionResource, AddBlockUpdateTest,
> SpatialHeatmapFacetsTest, RAMDirectoryFactoryTest,
> TestLMJelinekMercerSimilarityFactory, FileUtilsTest,
> FieldAnalysisRequestHandlerTest, AsyncMigrateRouteKeyTest,
> TestDynamicLoading, ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test,
> CollectionsAPIDistributedZkTest, OverseerTest,
> LeaderElectionIntegrationTest, TestReplicationHandler, AutoCommitTest,
> TestDistributedGrouping, TestFaceting, DistributedSpellCheckComponentTest,
> TermVectorComponentDistributedTest, ZkControllerTest, TestStressReorder,
> TestJoin, TestStressVersions, DistributedTermsComponentTest,
> TestRangeQuery, TestSolr4Spatial, SolrCoreTest, StatsComponentTest,
> SpellCheckComponentTest, TestGroupingSearch, QueryElevationComponentTest,
> PeerSyncTest, BadIndexSchemaTest, ConvertedLegacyTest, TestSort,
> BasicFunctionalityTest, HighlighterTest, ShowFileRequestHandlerTest,
> DistributedQueryElevationComponentTest,
> SignatureUpdateProcessorFactoryTest, SuggesterFSTTest, SuggesterTSTTest,
> SuggesterWFSTTest, WordBreakSolrSpellCheckerTest, TestUpdate,
> SortByFunctionTest, TestRemoteStreaming, DocValuesMultiTest,
> DistanceFunctionTest, XsltUpdateRequestHandlerTest, DebugComponentTest,
> TestSurroundQueryParser, DisMaxRequestHandlerTest, TestQueryUtils,
> TestWriterPerf, TestQueryTypes, TermsComponentTest, TestValueSourceCache,
> TestIndexingPerformance, TestSolrQueryParser, ReturnFieldsTest,
> TestAnalyzedSuggestions, CSVRequestHandlerTest, TestComponentsName,
> SearchHandlerTest, TestBinaryResponseWriter, TestLFUCache, PluginInfoTest,
> DateMathParserTest, TestSystemIdResolver, TestSuggestSpellingConverter,
> TestSolrJ, TestUtils, TestDocumentBuilder, SystemInfoHandlerTest,
> CursorPagingTest, SolrTestCaseJ4Test, TestCrossCoreJoin,
> TestDistributedMissingSort, TestHighlightDedupGrouping,
> CdcrVersionReplicationTest, CollectionReloadTest,
> ConcurrentDeleteAndCreateCollectionTest, ConnectionManagerTest,
> CustomCollectionTest, DistribCursorPagingTest, MultiThreadedOCPTest,
> SimpleCollectionCreateDeleteTest, TestConfigSetsAPIExclusivity,
> TestConfigSetsAPIZkFailure, TestLeaderElectionZkExpiry,
> TestMiniSolrCloudCluster, TestRebalanceLeaders, TestRequestForwarding,
> TestSolrCloudWithKerberosAlt, VMParamsZkACLAndCredentialsProvidersTest,
> HdfsBasicDistributedZkTest, HdfsChaosMonkeyNothingIsSafeTest,
> HdfsCollectionsAPIDistributedZkTest, HdfsThreadLeakTest, StressHdfsTest,
> ZkStateReaderTest, TestReplicationHandlerBackup]
> [junit4] Completed [472/564 (1!)] on J1 in 4.53s, 2 tests, 1 failure
> <<< FAILURES!
>
> [...truncated 314 lines...]
> BUILD FAILED
> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:784:
> The following error occurred while executing this line:
> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:728:
> 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:516:
> The following error occurred while executing this line:
> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1436:
> The following error occurred while executing this line:
> C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:991:
> There were test failures: 564 suites (8 ignored), 2241 tests, 1 failure,
> 123 ignored (79 assumptions) [seed: 6E9F182550A30A29]
>
> Total time: 70 minutes 54 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
>
>
--
Regards,
Varun Thacker