Build: https://builds.apache.org/job/Lucene-Solr-Tests-trunk-Java8/58/
1 tests failed.
REGRESSION: 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([4227D1C85AD27B58:3ACF1AD7D6C8817]: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:483)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 9556 lines...]
[junit4] Suite: org.apache.solr.handler.TestReplicationHandlerBackup
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/init-core-data-001
[junit4] 2> 229989 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testBackupOnCommit
[junit4] 2> 229990 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/collection1
[junit4] 2> 230004 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] o.e.j.s.Server jetty-9.2.10.v20150310
[junit4] 2> 230034 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@69e47046{/solr,null,AVAILABLE}
[junit4] 2> 230050 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] o.e.j.s.ServerConnector Started
ServerConnector@4d97a9a8{HTTP/1.1}{127.0.0.1:37736}
[junit4] 2> 230050 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] o.e.j.s.Server Started @233210ms
[junit4] 2> 230050 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/collection1/data,
hostContext=/solr, hostPort=37736}
[junit4] 2> 230051 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] o.a.s.s.SolrDispatchFilter
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@c387f44
[junit4] 2> 230051 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/'
[junit4] 2> 230064 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/solr.xml
[junit4] 2> 230076 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] o.a.s.c.CoresLocator Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/.
[junit4] 2> 230076 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] o.a.s.c.CoreContainer New CoreContainer 842235737
[junit4] 2> 230077 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/]
[junit4] 2> 230077 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] o.a.s.c.CoreContainer loading shared library:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/lib
[junit4] 2> 230077 WARN
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to
classloader: lib (resolved as:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/lib).
[junit4] 2> 230122 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] 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> 230123 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with
params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 230124 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 230124 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 230124 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 230233 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] o.a.s.c.CoresLocator Looking for core definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/.
[junit4] 2> 230235 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1,
config=solrconfig.xml,
instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/./collection1,
loadOnStartup=true,
absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/./collection1/,
schema=schema.xml, transient=false, dataDir=data/}
[junit4] 2> 230235 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] o.a.s.c.CoresLocator Found core collection1 in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/./collection1/
[junit4] 2> 230235 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] o.a.s.c.CoresLocator Found 1 core definitions
[junit4] 2> 230255 INFO (coreLoadExecutor-708-thread-1) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/./collection1/'
[junit4] 2> 230263 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] o.a.s.s.SolrDispatchFilter
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1
[junit4] 2> 230272 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 230286 INFO (coreLoadExecutor-708-thread-1) [ ]
o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 230289 INFO (coreLoadExecutor-708-thread-1) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 230295 INFO (coreLoadExecutor-708-thread-1) [ ]
o.a.s.c.Config Loaded SolrConfig: solrconfig.xml
[junit4] 2> 230296 INFO (coreLoadExecutor-708-thread-1) [ ]
o.a.s.s.IndexSchema Reading Solr Schema from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/./collection1/conf/schema.xml
[junit4] 2> 230298 INFO (coreLoadExecutor-708-thread-1) [ ]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 230300 INFO (coreLoadExecutor-708-thread-1) [ ]
o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 230300 INFO (coreLoadExecutor-708-thread-1) [ ]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
instancedir
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/./collection1/
[junit4] 2> 230301 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 230301 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/./collection1/],
dataDir=[null]
[junit4] 2> 230301 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core:
collection1
[junit4] 2> 230301 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/./collection1/data
[junit4] 2> 230302 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/./collection1/data/index/
[junit4] 2> 230302 WARN (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/./collection1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 230302 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/./collection1/data/index
[junit4] 2> 230302 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=34, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 230303 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@7a824bed
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@479f8c61),segFN=segments_1,generation=1}
[junit4] 2> 230303 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 230305 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as
default, creating implicit default
[junit4] 2> 230306 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 230327 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 230333 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 230341 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 230346 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with
startup=lazy
[junit4] 2> 230346 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.c.RequestHandlers Registered paths:
/admin/mbeans,standard,lazy,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,defaults,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
[junit4] 2> 230347 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.c.SolrCore Using default statsCache cache:
org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 230347 INFO
(OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1]
o.a.s.c.SolrCore Looking for old index directories to cleanup for core
collection1 in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/./collection1/data/
[junit4] 2> 230355 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
[junit4] 2> 230355 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
[junit4] 2> 230356 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=50, maxMergeAtOnceExplicit=41, maxMergedSegmentMB=84.10546875,
floorSegmentMB=2.07421875, forceMergeDeletesPctAllowed=13.023424238792984,
segmentsPerTier=30.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.703374758688617
[junit4] 2> 230356 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@7a824bed
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@479f8c61),segFN=segments_1,generation=1}
[junit4] 2> 230356 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 230356 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@3d0c8abc[collection1]
main
[junit4] 2> 230357 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to
use dir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/./collection1/conf
[junit4] 2> 230357 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs:
{storageDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/./collection1/conf}
[junit4] 2> 230357 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using
file:dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/./collection1/conf
[junit4] 2> 230357 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 230357 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following
config files: schema-replication2.xml:schema.xml
[junit4] 2> 230357 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 230358 INFO (coreLoadExecutor-708-thread-1) [
x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 230375 INFO
(searcherExecutor-709-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@3d0c8abc[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 230789 INFO (qtp1399492652-2312) [ x:collection1]
o.a.s.c.SolrCore [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 230790 INFO (qtp1399492652-2312) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {deleteByQuery=*:*} 0 1
[junit4] 2> 230798 INFO (qtp1399492652-2313) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[0]} 0 6
[junit4] 2> 230803 INFO (qtp1399492652-2314) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[1]} 0 0
[junit4] 2> 230805 INFO (qtp1399492652-2315) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[2]} 0 0
[junit4] 2> 230812 INFO (qtp1399492652-2316) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[3]} 0 1
[junit4] 2> 230814 INFO (qtp1399492652-2312) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[4]} 0 0
[junit4] 2> 230827 INFO (qtp1399492652-2313) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[5]} 0 0
[junit4] 2> 230832 INFO (qtp1399492652-2314) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[6]} 0 1
[junit4] 2> 230834 INFO (qtp1399492652-2315) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[7]} 0 0
[junit4] 2> 230836 INFO (qtp1399492652-2316) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[8]} 0 0
[junit4] 2> 230838 INFO (qtp1399492652-2312) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[9]} 0 0
[junit4] 2> 230840 INFO (qtp1399492652-2313) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[10]} 0 0
[junit4] 2> 230842 INFO (qtp1399492652-2314) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[11]} 0 0
[junit4] 2> 230844 INFO (qtp1399492652-2315) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[12]} 0 0
[junit4] 2> 230846 INFO (qtp1399492652-2316) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[13]} 0 0
[junit4] 2> 230848 INFO (qtp1399492652-2312) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[14]} 0 1
[junit4] 2> 230849 INFO (qtp1399492652-2313) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[15]} 0 0
[junit4] 2> 230851 INFO (qtp1399492652-2314) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[16]} 0 0
[junit4] 2> 230853 INFO (qtp1399492652-2315) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[17]} 0 0
[junit4] 2> 230855 INFO (qtp1399492652-2316) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[18]} 0 1
[junit4] 2> 230856 INFO (qtp1399492652-2312) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[19]} 0 0
[junit4] 2> 230858 INFO (qtp1399492652-2313) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[20]} 0 0
[junit4] 2> 230860 INFO (qtp1399492652-2314) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[21]} 0 0
[junit4] 2> 230861 INFO (qtp1399492652-2315) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[22]} 0 0
[junit4] 2> 230863 INFO (qtp1399492652-2316) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[23]} 0 0
[junit4] 2> 230865 INFO (qtp1399492652-2312) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[24]} 0 0
[junit4] 2> 230867 INFO (qtp1399492652-2313) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[25]} 0 0
[junit4] 2> 230868 INFO (qtp1399492652-2314) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[26]} 0 0
[junit4] 2> 230870 INFO (qtp1399492652-2315) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[27]} 0 0
[junit4] 2> 230872 INFO (qtp1399492652-2316) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[28]} 0 0
[junit4] 2> 230874 INFO (qtp1399492652-2312) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[29]} 0 1
[junit4] 2> 230875 INFO (qtp1399492652-2313) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[30]} 0 0
[junit4] 2> 230877 INFO (qtp1399492652-2314) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[31]} 0 0
[junit4] 2> 230879 INFO (qtp1399492652-2315) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[32]} 0 1
[junit4] 2> 230880 INFO (qtp1399492652-2316) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[33]} 0 0
[junit4] 2> 230882 INFO (qtp1399492652-2312) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[34]} 0 0
[junit4] 2> 230883 INFO (qtp1399492652-2313) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[35]} 0 0
[junit4] 2> 230885 INFO (qtp1399492652-2314) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[36]} 0 0
[junit4] 2> 230887 INFO (qtp1399492652-2315) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[37]} 0 0
[junit4] 2> 230889 INFO (qtp1399492652-2316) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[38]} 0 1
[junit4] 2> 230890 INFO (qtp1399492652-2312) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[39]} 0 0
[junit4] 2> 230895 INFO (qtp1399492652-2313) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[40]} 0 0
[junit4] 2> 230897 INFO (qtp1399492652-2314) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[41]} 0 0
[junit4] 2> 230899 INFO (qtp1399492652-2315) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[42]} 0 0
[junit4] 2> 230901 INFO (qtp1399492652-2316) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[43]} 0 0
[junit4] 2> 230902 INFO (qtp1399492652-2312) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[44]} 0 0
[junit4] 2> 230919 INFO (qtp1399492652-2313) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[45]} 0 0
[junit4] 2> 230921 INFO (qtp1399492652-2314) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[46]} 0 0
[junit4] 2> 230923 INFO (qtp1399492652-2315) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[47]} 0 0
[junit4] 2> 230925 INFO (qtp1399492652-2316) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[48]} 0 0
[junit4] 2> 230927 INFO (qtp1399492652-2312) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[49]} 0 0
[junit4] 2> 230928 INFO (qtp1399492652-2313) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[50]} 0 0
[junit4] 2> 230930 INFO (qtp1399492652-2314) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[51]} 0 0
[junit4] 2> 230932 INFO (qtp1399492652-2315) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[52]} 0 0
[junit4] 2> 230933 INFO (qtp1399492652-2316) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[53]} 0 0
[junit4] 2> 230935 INFO (qtp1399492652-2312) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[54]} 0 0
[junit4] 2> 230937 INFO (qtp1399492652-2313) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[55]} 0 0
[junit4] 2> 230939 INFO (qtp1399492652-2314) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[56]} 0 0
[junit4] 2> 230940 INFO (qtp1399492652-2315) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[57]} 0 0
[junit4] 2> 230942 INFO (qtp1399492652-2316) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[58]} 0 0
[junit4] 2> 230944 INFO (qtp1399492652-2312) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[59]} 0 0
[junit4] 2> 230945 INFO (qtp1399492652-2313) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[60]} 0 0
[junit4] 2> 230947 INFO (qtp1399492652-2314) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[61]} 0 0
[junit4] 2> 230949 INFO (qtp1399492652-2315) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[62]} 0 0
[junit4] 2> 230951 INFO (qtp1399492652-2316) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[63]} 0 1
[junit4] 2> 230952 INFO (qtp1399492652-2312) [ x:collection1]
o.a.s.u.UpdateHandler start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 230976 INFO (qtp1399492652-2312) [ x:collection1]
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@7a824bed
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@479f8c61),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@7a824bed
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@479f8c61),segFN=segments_2,generation=2}
[junit4] 2> 230976 INFO (qtp1399492652-2312) [ x:collection1]
o.a.s.c.SolrCore newest commit generation = 2
[junit4] 2> 230991 INFO (Thread-1327) [ x:collection1]
o.a.s.h.SnapShooter Creating backup snapshot <not named> at
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/./collection1/data/
[junit4] 2> 230996 INFO (qtp1399492652-2312) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening Searcher@50bb126c[collection1] main
[junit4] 2> 230997 INFO
(searcherExecutor-709-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@50bb126c[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c64)))}
[junit4] 2> 230997 INFO (qtp1399492652-2312) [ x:collection1]
o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 230997 INFO (qtp1399492652-2312) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
{commit=} 0 45
[junit4] 2> 231003 INFO (Thread-1327) [ x:collection1]
o.a.s.h.SnapShooter Done creating backup snapshot: <not named> at
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/./collection1/data/
[junit4] 2> 231005 INFO (qtp1399492652-2313) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={command=details} status=0 QTime=1
[junit4] 2> 232060 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testBackupOnCommit
[junit4] 2> 232088 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] o.e.j.s.ServerConnector Stopped
ServerConnector@4d97a9a8{HTTP/1.1}{127.0.0.1:0}
[junit4] 2> 232088 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=842235737
[junit4] 2> 232123 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@6623c1e3
[junit4] 2> 232123 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ x:collection1] o.a.s.u.UpdateHandler 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=64,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
[junit4] 2> 232124 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 232124 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has
reached 0 - closing IndexWriter
[junit4] 2> 232124 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with
IndexWriterCloser
[junit4] 2> 232125 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on
request.
[junit4] 2> 232125 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ x:collection1] o.a.s.c.CachingDirectoryFactory Closing
MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 232125 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/./collection1/data/index
[CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/./collection1/data/index;done=false>>]
[junit4] 2> 232125 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/./collection1/data/index
[junit4] 2> 232125 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/./collection1/data
[CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/./collection1/data;done=false>>]
[junit4] 2> 232125 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-001/./collection1/data
[junit4] 2> 232126 INFO
(TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[4227D1C85AD27B58])
[ x:collection1] o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@69e47046{/solr,null,UNAVAILABLE}
[junit4] 2> 232140 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting doTestBackup
[junit4] 2> 232140 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/collection1
[junit4] 2> 232171 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
o.e.j.s.Server jetty-9.2.10.v20150310
[junit4] 2> 232350 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@62b99d21{/solr,null,AVAILABLE}
[junit4] 2> 232351 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@14a70689{HTTP/1.1}{127.0.0.1:60223}
[junit4] 2> 232351 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
o.e.j.s.Server Started @235511ms
[junit4] 2> 232351 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/collection1/data,
hostContext=/solr, hostPort=60223}
[junit4] 2> 232352 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
o.a.s.s.SolrDispatchFilter
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@c387f44
[junit4] 2> 232352 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/'
[junit4] 2> 232379 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/solr.xml
[junit4] 2> 232425 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
o.a.s.c.CoresLocator Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/.
[junit4] 2> 232425 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
o.a.s.c.CoreContainer New CoreContainer 394571533
[junit4] 2> 232425 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/]
[junit4] 2> 232425 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
o.a.s.c.CoreContainer loading shared library:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/lib
[junit4] 2> 232426 WARN
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to
classloader: lib (resolved as:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/lib).
[junit4] 2> 232440 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
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> 232500 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 232500 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 232501 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 232501 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 232501 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
o.a.s.c.CoresLocator Looking for core definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/.
[junit4] 2> 232502 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1,
config=solrconfig.xml,
instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/./collection1,
loadOnStartup=true,
absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/./collection1/,
schema=schema.xml, transient=false, dataDir=data/}
[junit4] 2> 232502 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
o.a.s.c.CoresLocator Found core collection1 in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/./collection1/
[junit4] 2> 232502 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
o.a.s.c.CoresLocator Found 1 core definitions
[junit4] 2> 232506 INFO (coreLoadExecutor-718-thread-1) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/./collection1/'
[junit4] 2> 232556 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
o.a.s.s.SolrDispatchFilter
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1
[junit4] 2> 232556 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 232598 INFO (coreLoadExecutor-718-thread-1) [ ]
o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 232631 INFO (coreLoadExecutor-718-thread-1) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 232643 INFO (coreLoadExecutor-718-thread-1) [ ]
o.a.s.c.Config Loaded SolrConfig: solrconfig.xml
[junit4] 2> 232643 INFO (coreLoadExecutor-718-thread-1) [ ]
o.a.s.s.IndexSchema Reading Solr Schema from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/./collection1/conf/schema.xml
[junit4] 2> 232646 INFO (coreLoadExecutor-718-thread-1) [ ]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 232677 INFO (coreLoadExecutor-718-thread-1) [ ]
o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 232677 INFO (coreLoadExecutor-718-thread-1) [ ]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
instancedir
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/./collection1/
[junit4] 2> 232677 INFO (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 232677 INFO (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/./collection1/],
dataDir=[null]
[junit4] 2> 232678 INFO (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core:
collection1
[junit4] 2> 232697 INFO (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/./collection1/data
[junit4] 2> 232707 INFO (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/./collection1/data/index/
[junit4] 2> 232707 WARN (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/./collection1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 232708 INFO (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/./collection1/data/index
[junit4] 2> 232708 INFO (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=34, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 232711 INFO (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@62b19d23
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5b110095),segFN=segments_1,generation=1}
[junit4] 2> 232711 INFO (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 232713 INFO (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as
default, creating implicit default
[junit4] 2> 232715 INFO (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 232716 INFO (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 232717 INFO (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 232717 INFO (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 232719 INFO (coreLoadExecutor-718-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> 232719 INFO
(OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1]
o.a.s.c.SolrCore Looking for old index directories to cleanup for core
collection1 in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/./collection1/data/
[junit4] 2> 232727 INFO (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.c.SolrCore Using default statsCache cache:
org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 232727 INFO (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
[junit4] 2> 232727 INFO (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
[junit4] 2> 232728 INFO (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=50, maxMergeAtOnceExplicit=41, maxMergedSegmentMB=84.10546875,
floorSegmentMB=2.07421875, forceMergeDeletesPctAllowed=13.023424238792984,
segmentsPerTier=30.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.703374758688617
[junit4] 2> 232729 INFO (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@62b19d23
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5b110095),segFN=segments_1,generation=1}
[junit4] 2> 232729 INFO (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 232729 INFO (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@7c05c8bc[collection1]
main
[junit4] 2> 232729 INFO (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to
use dir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/./collection1/conf
[junit4] 2> 232729 INFO (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs:
{storageDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/./collection1/conf}
[junit4] 2> 232730 INFO (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using
file:dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/./collection1/conf
[junit4] 2> 232730 INFO (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 232730 INFO (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following
config files: schema-replication2.xml:schema.xml
[junit4] 2> 232730 INFO (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 232730 INFO (coreLoadExecutor-718-thread-1) [
x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 232732 INFO
(searcherExecutor-719-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@7c05c8bc[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 233110 INFO (qtp827036934-2333) [ x:collection1]
o.a.s.c.SolrCore [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 233110 INFO (qtp827036934-2333) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {deleteByQuery=*:*} 0 0
[junit4] 2> 233113 INFO (qtp827036934-2334) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[0]} 0 1
[junit4] 2> 233115 INFO (qtp827036934-2335) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[1]} 0 0
[junit4] 2> 233117 INFO (qtp827036934-2336) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[2]} 0 0
[junit4] 2> 233119 INFO (qtp827036934-2337) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[3]} 0 0
[junit4] 2> 233121 INFO (qtp827036934-2333) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[4]} 0 0
[junit4] 2> 233142 INFO (qtp827036934-2334) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[5]} 0 1
[junit4] 2> 233143 INFO (qtp827036934-2335) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[6]} 0 0
[junit4] 2> 233146 INFO (qtp827036934-2336) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[7]} 0 1
[junit4] 2> 233148 INFO (qtp827036934-2337) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[8]} 0 0
[junit4] 2> 233150 INFO (qtp827036934-2333) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[9]} 0 0
[junit4] 2> 233167 INFO (qtp827036934-2334) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[10]} 0 0
[junit4] 2> 233170 INFO (qtp827036934-2335) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[11]} 0 1
[junit4] 2> 233171 INFO (qtp827036934-2336) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[12]} 0 0
[junit4] 2> 233173 INFO (qtp827036934-2337) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[13]} 0 0
[junit4] 2> 233175 INFO (qtp827036934-2333) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[14]} 0 0
[junit4] 2> 233177 INFO (qtp827036934-2334) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[15]} 0 0
[junit4] 2> 233178 INFO (qtp827036934-2335) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[16]} 0 0
[junit4] 2> 233182 INFO (qtp827036934-2336) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[17]} 0 0
[junit4] 2> 233184 INFO (qtp827036934-2337) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[18]} 0 0
[junit4] 2> 233185 INFO (qtp827036934-2333) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[19]} 0 0
[junit4] 2> 233191 INFO (qtp827036934-2334) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[20]} 0 0
[junit4] 2> 233193 INFO (qtp827036934-2335) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[21]} 0 0
[junit4] 2> 233197 INFO (qtp827036934-2336) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[22]} 0 0
[junit4] 2> 233199 INFO (qtp827036934-2337) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[23]} 0 0
[junit4] 2> 233201 INFO (qtp827036934-2333) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[24]} 0 0
[junit4] 2> 233203 INFO (qtp827036934-2334) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[25]} 0 0
[junit4] 2> 233205 INFO (qtp827036934-2335) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[26]} 0 0
[junit4] 2> 233207 INFO (qtp827036934-2336) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[27]} 0 0
[junit4] 2> 233208 INFO (qtp827036934-2337) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[28]} 0 0
[junit4] 2> 233210 INFO (qtp827036934-2333) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[29]} 0 0
[junit4] 2> 233214 INFO (qtp827036934-2334) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[30]} 0 1
[junit4] 2> 233215 INFO (qtp827036934-2335) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[31]} 0 0
[junit4] 2> 233217 INFO (qtp827036934-2336) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[32]} 0 0
[junit4] 2> 233223 INFO (qtp827036934-2337) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[33]} 0 4
[junit4] 2> 233225 INFO (qtp827036934-2333) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[34]} 0 0
[junit4] 2> 233227 INFO (qtp827036934-2334) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[35]} 0 0
[junit4] 2> 233229 INFO (qtp827036934-2335) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[36]} 0 0
[junit4] 2> 233231 INFO (qtp827036934-2336) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[37]} 0 0
[junit4] 2> 233232 INFO (qtp827036934-2337) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[38]} 0 0
[junit4] 2> 233234 INFO (qtp827036934-2333) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[39]} 0 0
[junit4] 2> 233238 INFO (qtp827036934-2334) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[40]} 0 1
[junit4] 2> 233242 INFO (qtp827036934-2335) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[41]} 0 0
[junit4] 2> 233244 INFO (qtp827036934-2336) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[42]} 0 0
[junit4] 2> 233246 INFO (qtp827036934-2337) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[43]} 0 0
[junit4] 2> 233248 INFO (qtp827036934-2333) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[44]} 0 1
[junit4] 2> 233538 INFO (qtp827036934-2334) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[45]} 0 0
[junit4] 2> 233542 INFO (qtp827036934-2335) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[46]} 0 1
[junit4] 2> 233543 INFO (qtp827036934-2336) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[47]} 0 0
[junit4] 2> 233545 INFO (qtp827036934-2337) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[48]} 0 0
[junit4] 2> 233547 INFO (qtp827036934-2333) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[49]} 0 0
[junit4] 2> 233551 INFO (qtp827036934-2334) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[50]} 0 0
[junit4] 2> 233553 INFO (qtp827036934-2335) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[51]} 0 0
[junit4] 2> 233559 INFO (qtp827036934-2336) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[52]} 0 0
[junit4] 2> 233561 INFO (qtp827036934-2337) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[53]} 0 0
[junit4] 2> 233563 INFO (qtp827036934-2333) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[54]} 0 0
[junit4] 2> 233565 INFO (qtp827036934-2334) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[55]} 0 1
[junit4] 2> 233566 INFO (qtp827036934-2335) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[56]} 0 0
[junit4] 2> 233568 INFO (qtp827036934-2336) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[57]} 0 0
[junit4] 2> 233570 INFO (qtp827036934-2337) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[58]} 0 0
[junit4] 2> 233572 INFO (qtp827036934-2333) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[59]} 0 0
[junit4] 2> 233574 INFO (qtp827036934-2334) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[60]} 0 0
[junit4] 2> 233576 INFO (qtp827036934-2335) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[61]} 0 0
[junit4] 2> 233578 INFO (qtp827036934-2336) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[62]} 0 1
[junit4] 2> 233579 INFO (qtp827036934-2337) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[63]} 0 0
[junit4] 2> 233581 INFO (qtp827036934-2333) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[64]} 0 0
[junit4] 2> 233588 INFO (qtp827036934-2334) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[65]} 0 1
[junit4] 2> 233590 INFO (qtp827036934-2335) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[66]} 0 0
[junit4] 2> 233592 INFO (qtp827036934-2336) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[67]} 0 0
[junit4] 2> 233593 INFO (qtp827036934-2337) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[68]} 0 0
[junit4] 2> 233595 INFO (qtp827036934-2333) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[69]} 0 0
[junit4] 2> 233597 INFO (qtp827036934-2334) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[70]} 0 0
[junit4] 2> 233599 INFO (qtp827036934-2335) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[71]} 0 0
[junit4] 2> 233600 INFO (qtp827036934-2336) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[72]} 0 0
[junit4] 2> 233602 INFO (qtp827036934-2337) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[73]} 0 0
[junit4] 2> 233604 INFO (qtp827036934-2333) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[74]} 0 0
[junit4] 2> 233606 INFO (qtp827036934-2334) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[75]} 0 1
[junit4] 2> 233607 INFO (qtp827036934-2335) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[76]} 0 0
[junit4] 2> 233609 INFO (qtp827036934-2336) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[77]} 0 0
[junit4] 2> 233611 INFO (qtp827036934-2337) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[78]} 0 0
[junit4] 2> 233614 INFO (qtp827036934-2333) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[79]} 0 0
[junit4] 2> 233623 INFO (qtp827036934-2334) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[80]} 0 0
[junit4] 2> 233625 INFO (qtp827036934-2335) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[81]} 0 0
[junit4] 2> 233628 INFO (qtp827036934-2336) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[82]} 0 0
[junit4] 2> 233631 INFO (qtp827036934-2337) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[83]} 0 1
[junit4] 2> 233633 INFO (qtp827036934-2333) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[84]} 0 0
[junit4] 2> 233635 INFO (qtp827036934-2334) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[85]} 0 0
[junit4] 2> 233636 INFO (qtp827036934-2335) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[86]} 0 0
[junit4] 2> 233638 INFO (qtp827036934-2336) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[87]} 0 0
[junit4] 2> 233640 INFO (qtp827036934-2337) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[88]} 0 0
[junit4] 2> 233643 INFO (qtp827036934-2333) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[89]} 0 0
[junit4] 2> 233645 INFO (qtp827036934-2334) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[90]} 0 0
[junit4] 2> 233647 INFO (qtp827036934-2335) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[91]} 0 0
[junit4] 2> 233648 INFO (qtp827036934-2336) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[92]} 0 0
[junit4] 2> 233650 INFO (qtp827036934-2337) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[93]} 0 0
[junit4] 2> 233654 INFO (qtp827036934-2333) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[94]} 0 0
[junit4] 2> 233656 INFO (qtp827036934-2334) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[95]} 0 0
[junit4] 2> 233658 INFO (qtp827036934-2335) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[96]} 0 0
[junit4] 2> 233660 INFO (qtp827036934-2336) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[97]} 0 1
[junit4] 2> 233661 INFO (qtp827036934-2337) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[98]} 0 0
[junit4] 2> 233663 INFO (qtp827036934-2333) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={wt=javabin&version=2} {add=[99]} 0 0
[junit4] 2> 233665 INFO (qtp827036934-2334) [ x:collection1]
o.a.s.u.UpdateHandler start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 233669 INFO (qtp827036934-2334) [ x:collection1]
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@62b19d23
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5b110095),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@62b19d23
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5b110095),segFN=segments_2,generation=2}
[junit4] 2> 233669 INFO (qtp827036934-2334) [ x:collection1]
o.a.s.c.SolrCore newest commit generation = 2
[junit4] 2> 233675 INFO (Thread-1342) [ x:collection1]
o.a.s.h.SnapShooter Creating backup snapshot <not named> at
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/./collection1/data/
[junit4] 2> 233676 INFO (qtp827036934-2334) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening Searcher@ba240cd[collection1] main
[junit4] 2> 233676 INFO
(searcherExecutor-719-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@ba240cd[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c100)))}
[junit4] 2> 233677 INFO (qtp827036934-2334) [ x:collection1]
o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 233677 INFO (qtp827036934-2334) [ x:collection1]
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
{commit=} 0 12
[junit4] 2> 233689 INFO (qtp827036934-2335) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={command=backup} status=0 QTime=9
[junit4] 2> 233691 INFO (Thread-1343) [ x:collection1]
o.a.s.h.SnapShooter Creating backup snapshot <not named> at
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/./collection1/data/
[junit4] 2> 233692 INFO (Thread-1343) [ x:collection1]
o.a.s.h.SnapShooter Done creating backup snapshot: <not named> at
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/./collection1/data/
[junit4] 2> 233697 ERROR (Thread-1342) [ x:collection1]
o.a.s.h.SnapShooter Exception while creating snapshot
[junit4] 2> java.nio.file.NoSuchFileException:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/collection1/data/snapshot.20150610033917151/_0.cfs
[junit4] 2> at
sun.nio.fs.UnixException.translateToIOException(UnixException.java:86)
[junit4] 2> at
sun.nio.fs.UnixException.rethrowAsIOException(UnixException.java:102)
[junit4] 2> at
sun.nio.fs.UnixException.rethrowAsIOException(UnixException.java:107)
[junit4] 2> at
sun.nio.fs.UnixFileSystemProvider.newByteChannel(UnixFileSystemProvider.java:214)
[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:262)
[junit4] 2> at
org.apache.lucene.store.FSDirectory.createOutput(FSDirectory.java:211)
[junit4] 2> at
org.apache.lucene.store.Directory.copyFrom(Directory.java:151)
[junit4] 2> at
org.apache.solr.handler.SnapShooter.copyFiles(SnapShooter.java:206)
[junit4] 2> at
org.apache.solr.handler.SnapShooter.createSnapshot(SnapShooter.java:139)
[junit4] 2> at
org.apache.solr.handler.SnapShooter$1.run(SnapShooter.java:88)
[junit4] 2> 233705 INFO (qtp827036934-2336) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={command=details} status=0 QTime=1
[junit4] 2> 233706 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending doTestBackup
[junit4] 2> 233723 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
o.e.j.s.ServerConnector Stopped ServerConnector@14a70689{HTTP/1.1}{127.0.0.1:0}
[junit4] 2> 233724 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=394571533
[junit4] 2> 233724 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@25c35407
[junit4] 2> 233724 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [
x:collection1] o.a.s.u.UpdateHandler 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=100,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
[junit4] 2> 233724 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [
x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 233725 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [
x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached
0 - closing IndexWriter
[junit4] 2> 233725 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [
x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with
IndexWriterCloser
[junit4] 2> 233731 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [
x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
[junit4] 2> 233731 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [
x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2
directories currently being tracked
[junit4] 2> 233732 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/./collection1/data/index
[CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/./collection1/data/index;done=false>>]
[junit4] 2> 233732 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/./collection1/data/index
[junit4] 2> 233732 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/./collection1/data
[CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/./collection1/data;done=false>>]
[junit4] 2> 233732 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001/solr-instance-002/./collection1/data
[junit4] 2> 233733 INFO
(TEST-TestReplicationHandlerBackup.doTestBackup-seed#[4227D1C85AD27B58]) [
x:collection1] o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@62b99d21{/solr,null,UNAVAILABLE}
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=TestReplicationHandlerBackup -Dtests.method=doTestBackup
-Dtests.seed=4227D1C85AD27B58 -Dtests.multiplier=2 -Dtests.slow=true
-Dtests.locale=lv_LV -Dtests.timezone=Europe/Luxembourg -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[junit4] FAILURE 1.60s J1 | TestReplicationHandlerBackup.doTestBackup <<<
[junit4] > Throwable #1: java.lang.AssertionError: Failed to create backup
[junit4] > at
__randomizedtesting.SeedInfo.seed([4227D1C85AD27B58:3ACF1AD7D6C8817]: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> 233740 INFO
(SUITE-TestReplicationHandlerBackup-seed#[4227D1C85AD27B58]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandlerBackup_4227D1C85AD27B58-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene50):
{name=Lucene50(blocksize=128), id=Lucene50(blocksize=128)}, docValues:{},
sim=DefaultSimilarity, locale=lv_LV, timezone=Europe/Luxembourg
[junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation
1.8.0_25 (64-bit)/cpus=4,threads=1,free=97928808,total=375914496
[junit4] 2> NOTE: All tests run in this JVM: [ActionThrottleTest,
TestCloudManagedSchema, TestManagedSchemaFieldResource, ShardRoutingTest,
TestLRUStatsCache, TestLRUCache, TestStressUserVersions,
TestAtomicUpdateErrorCases, AnalysisAfterCoreReloadTest, PreAnalyzedFieldTest,
RAMDirectoryFactoryTest, OpenCloseCoreStressTest,
OverriddenZkACLAndCredentialsProvidersTest, TestShortCircuitedRequests,
StressHdfsTest, CurrencyFieldOpenExchangeTest, SliceStateTest,
FieldAnalysisRequestHandlerTest, BadComponentTest,
DistributedTermsComponentTest, AlternateDirectoryTest, QueryResultKeyTest,
ScriptEngineTest, BufferStoreTest, TestReplicationHandlerBackup]
[junit4] Completed [37/506] on J1 in 3.86s, 2 tests, 1 failure <<< FAILURES!
[...truncated 1435 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/build.xml:526:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/build.xml:474:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/build.xml:61:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/extra-targets.xml:39:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/build.xml:230:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/solr/common-build.xml:512:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/lucene/common-build.xml:1420:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-trunk-Java8/lucene/common-build.xml:975:
There were test failures: 506 suites, 1990 tests, 1 failure, 35 ignored (25
assumptions)
Total time: 50 minutes 13 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Sending artifact delta relative to Lucene-Solr-Tests-trunk-Java8 #57
Archived 4 artifacts
Archive block size is 32768
Received 0 blocks and 301534576 bytes
Compression is 0.0%
Took 44 sec
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
