lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@thetaphi.de>
Subject [JENKINS] Lucene-Solr-trunk-Windows (64bit/jdk1.8.0_60) - Build # 5202 - Failure!
Date Wed, 26 Aug 2015 11:55:22 GMT
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/5202/
Java: 64bit/jdk1.8.0_60 -XX:-UseCompressedOops -XX:+UseParallelGC

2 tests failed.
FAILED:  org.apache.solr.handler.TestReplicationHandlerBackup.doTestBackup

Error Message:
Test abandoned because suite timeout was reached.

Stack Trace:
java.lang.Exception: Test abandoned because suite timeout was reached.
	at __randomizedtesting.SeedInfo.seed([B466C333BCD6B09]:0)


FAILED:  junit.framework.TestSuite.org.apache.solr.handler.TestReplicationHandlerBackup

Error Message:
Suite timeout exceeded (>= 7200000 msec).

Stack Trace:
java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
	at __randomizedtesting.SeedInfo.seed([B466C333BCD6B09]:0)




Build Log:
[...truncated 11052 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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\init-core-data-001
   [junit4]   2> 2667536 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testBackupOnCommit
   [junit4]   2> 2667537 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\collection1
   [junit4]   2> 2667546 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] o.e.j.s.Server jetty-9.2.13.v20150730
   [junit4]   2> 2667548 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@52f8bdf8{/solr,null,AVAILABLE}
   [junit4]   2> 2667550 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] o.e.j.s.ServerConnector Started ServerConnector@39be83e5{HTTP/1.1}{127.0.0.1:57610}
   [junit4]   2> 2667550 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] o.e.j.s.Server Started @2678201ms
   [junit4]   2> 2667550 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] 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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\collection1\data, hostContext=/solr, hostPort=57610}
   [junit4]   2> 2667551 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a
   [junit4]   2> 2667551 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\'
   [junit4]   2> 2667569 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\solr.xml
   [junit4]   2> 2667577 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] o.a.s.c.CoresLocator Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\.
   [junit4]   2> 2667577 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] o.a.s.c.CoreContainer New CoreContainer 14928761
   [junit4]   2> 2667577 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\]
   [junit4]   2> 2667577 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] o.a.s.c.CoreContainer loading shared library: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\lib
   [junit4]   2> 2667577 WARN  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\lib).
   [junit4]   2> 2667584 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] 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> 2667586 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 2667587 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 2667587 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 2667587 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
   [junit4]   2> 2667587 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 2667588 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] o.a.s.c.CoresLocator Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\.
   [junit4]   2> 2667590 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\.\collection1, absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\.\collection1\, dataDir=data\}
   [junit4]   2> 2667590 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] o.a.s.c.CoresLocator Found core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\.\collection1\
   [junit4]   2> 2667591 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] o.a.s.c.CoresLocator Found 1 core definitions
   [junit4]   2> 2667592 INFO  (coreLoadExecutor-7752-thread-1) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\.\collection1\'
   [junit4]   2> 2667593 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] o.a.s.s.SolrDispatchFilter user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
   [junit4]   2> 2667593 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 2667611 INFO  (coreLoadExecutor-7752-thread-1) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 2667614 INFO  (coreLoadExecutor-7752-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
   [junit4]   2> 2667632 INFO  (coreLoadExecutor-7752-thread-1) [    ] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 2667632 INFO  (coreLoadExecutor-7752-thread-1) [    ] o.a.s.s.IndexSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\.\collection1\conf\schema.xml
   [junit4]   2> 2667635 INFO  (coreLoadExecutor-7752-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 2667637 INFO  (coreLoadExecutor-7752-thread-1) [    ] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 2667639 INFO  (coreLoadExecutor-7752-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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\.\collection1\conf'
   [junit4]   2> 2667639 INFO  (coreLoadExecutor-7752-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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\.\collection1\
   [junit4]   2> 2667640 INFO  (coreLoadExecutor-7752-thread-1) [    x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 2667640 INFO  (coreLoadExecutor-7752-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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\.\collection1\], dataDir=[null]
   [junit4]   2> 2667640 INFO  (coreLoadExecutor-7752-thread-1) [    x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
   [junit4]   2> 2667640 INFO  (coreLoadExecutor-7752-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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\.\collection1\data\
   [junit4]   2> 2667640 INFO  (coreLoadExecutor-7752-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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\.\collection1\data\index/
   [junit4]   2> 2667640 WARN  (coreLoadExecutor-7752-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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\.\collection1\data\index' doesn't exist. Creating new index...
   [junit4]   2> 2667640 INFO  (coreLoadExecutor-7752-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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\.\collection1\data\index
   [junit4]   2> 2667640 INFO  (coreLoadExecutor-7752-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=20, maxMergeAtOnceExplicit=48, maxMergedSegmentMB=5.9384765625, floorSegmentMB=2.0126953125, forceMergeDeletesPctAllowed=9.374951489217743, segmentsPerTier=45.0, maxCFSSegmentSizeMB=2.162109375, noCFSRatio=0.22244954677596518
   [junit4]   2> 2667640 INFO  (coreLoadExecutor-7752-thread-1) [    x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@10ef7c15 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7c62de0),segFN=segments_1,generation=1}
   [junit4]   2> 2667640 INFO  (coreLoadExecutor-7752-thread-1) [    x:collection1] o.a.s.c.SolrCore newest commit generation = 1
   [junit4]   2> 2667641 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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\.\collection1\data\
   [junit4]   2> 2667643 INFO  (coreLoadExecutor-7752-thread-1) [    x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 2667646 INFO  (coreLoadExecutor-7752-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 2667646 INFO  (coreLoadExecutor-7752-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 2667647 INFO  (coreLoadExecutor-7752-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 2667648 INFO  (coreLoadExecutor-7752-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 2667649 INFO  (coreLoadExecutor-7752-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> 2667650 INFO  (coreLoadExecutor-7752-thread-1) [    x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 2667650 INFO  (coreLoadExecutor-7752-thread-1) [    x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
   [junit4]   2> 2667650 INFO  (coreLoadExecutor-7752-thread-1) [    x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
   [junit4]   2> 2667650 INFO  (coreLoadExecutor-7752-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=45, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=95.9736328125, floorSegmentMB=1.8798828125, forceMergeDeletesPctAllowed=18.81393747742557, segmentsPerTier=11.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 2667650 INFO  (coreLoadExecutor-7752-thread-1) [    x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@10ef7c15 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7c62de0),segFN=segments_1,generation=1}
   [junit4]   2> 2667650 INFO  (coreLoadExecutor-7752-thread-1) [    x:collection1] o.a.s.c.SolrCore newest commit generation = 1
   [junit4]   2> 2667650 INFO  (coreLoadExecutor-7752-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@4fa5de4d[collection1] main
   [junit4]   2> 2667651 INFO  (coreLoadExecutor-7752-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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\.\collection1\conf
   [junit4]   2> 2667651 INFO  (coreLoadExecutor-7752-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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\.\collection1\conf}
   [junit4]   2> 2667651 INFO  (coreLoadExecutor-7752-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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\.\collection1\conf
   [junit4]   2> 2667651 INFO  (coreLoadExecutor-7752-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 2667651 INFO  (coreLoadExecutor-7752-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema-replication2.xml:schema.xml
   [junit4]   2> 2667651 INFO  (coreLoadExecutor-7752-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2667652 INFO  (searcherExecutor-7753-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4fa5de4d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2667652 INFO  (coreLoadExecutor-7752-thread-1) [    x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 2668025 INFO  (qtp1585873013-17698) [    x:collection1] o.a.s.c.SolrCore [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 2668025 INFO  (qtp1585873013-17698) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 0
   [junit4]   2> 2668028 INFO  (qtp1585873013-17699) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0]} 0 1
   [junit4]   2> 2668031 INFO  (qtp1585873013-17700) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1]} 0 0
   [junit4]   2> 2668033 INFO  (qtp1585873013-17701) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2]} 0 0
   [junit4]   2> 2668036 INFO  (qtp1585873013-17702) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[3]} 0 0
   [junit4]   2> 2668037 INFO  (qtp1585873013-17703) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[4]} 0 0
   [junit4]   2> 2668039 INFO  (qtp1585873013-17698) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[5]} 0 0
   [junit4]   2> 2668041 INFO  (qtp1585873013-17699) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[6]} 0 0
   [junit4]   2> 2668042 INFO  (qtp1585873013-17700) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[7]} 0 0
   [junit4]   2> 2668044 INFO  (qtp1585873013-17701) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[8]} 0 0
   [junit4]   2> 2668046 INFO  (qtp1585873013-17702) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[9]} 0 0
   [junit4]   2> 2668047 INFO  (qtp1585873013-17703) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[10]} 0 0
   [junit4]   2> 2668049 INFO  (qtp1585873013-17698) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[11]} 0 0
   [junit4]   2> 2668051 INFO  (qtp1585873013-17699) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[12]} 0 0
   [junit4]   2> 2668052 INFO  (qtp1585873013-17700) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[13]} 0 0
   [junit4]   2> 2668054 INFO  (qtp1585873013-17701) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[14]} 0 0
   [junit4]   2> 2668056 INFO  (qtp1585873013-17702) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[15]} 0 0
   [junit4]   2> 2668058 INFO  (qtp1585873013-17703) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[16]} 0 0
   [junit4]   2> 2668059 INFO  (qtp1585873013-17698) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[17]} 0 0
   [junit4]   2> 2668061 INFO  (qtp1585873013-17699) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[18]} 0 0
   [junit4]   2> 2668063 INFO  (qtp1585873013-17700) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[19]} 0 0
   [junit4]   2> 2668065 INFO  (qtp1585873013-17701) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[20]} 0 0
   [junit4]   2> 2668067 INFO  (qtp1585873013-17702) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[21]} 0 0
   [junit4]   2> 2668068 INFO  (qtp1585873013-17703) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[22]} 0 0
   [junit4]   2> 2668070 INFO  (qtp1585873013-17698) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[23]} 0 0
   [junit4]   2> 2668072 INFO  (qtp1585873013-17699) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[24]} 0 0
   [junit4]   2> 2668073 INFO  (qtp1585873013-17700) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[25]} 0 0
   [junit4]   2> 2668075 INFO  (qtp1585873013-17701) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[26]} 0 0
   [junit4]   2> 2668077 INFO  (qtp1585873013-17702) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[27]} 0 0
   [junit4]   2> 2668079 INFO  (qtp1585873013-17703) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[28]} 0 0
   [junit4]   2> 2668080 INFO  (qtp1585873013-17698) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[29]} 0 0
   [junit4]   2> 2668082 INFO  (qtp1585873013-17699) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[30]} 0 0
   [junit4]   2> 2668084 INFO  (qtp1585873013-17700) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[31]} 0 0
   [junit4]   2> 2668085 INFO  (qtp1585873013-17701) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[32]} 0 0
   [junit4]   2> 2668087 INFO  (qtp1585873013-17702) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[33]} 0 0
   [junit4]   2> 2668089 INFO  (qtp1585873013-17703) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[34]} 0 0
   [junit4]   2> 2668090 INFO  (qtp1585873013-17698) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[35]} 0 0
   [junit4]   2> 2668092 INFO  (qtp1585873013-17699) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[36]} 0 0
   [junit4]   2> 2668094 INFO  (qtp1585873013-17700) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[37]} 0 0
   [junit4]   2> 2668095 INFO  (qtp1585873013-17701) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[38]} 0 0
   [junit4]   2> 2668097 INFO  (qtp1585873013-17702) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[39]} 0 0
   [junit4]   2> 2668099 INFO  (qtp1585873013-17703) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[40]} 0 0
   [junit4]   2> 2668100 INFO  (qtp1585873013-17698) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[41]} 0 0
   [junit4]   2> 2668102 INFO  (qtp1585873013-17699) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[42]} 0 0
   [junit4]   2> 2668104 INFO  (qtp1585873013-17700) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[43]} 0 0
   [junit4]   2> 2668105 INFO  (qtp1585873013-17701) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[44]} 0 0
   [junit4]   2> 2668107 INFO  (qtp1585873013-17702) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[45]} 0 0
   [junit4]   2> 2668110 INFO  (qtp1585873013-17703) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[46]} 0 0
   [junit4]   2> 2668111 INFO  (qtp1585873013-17698) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[47]} 0 0
   [junit4]   2> 2668113 INFO  (qtp1585873013-17699) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[48]} 0 0
   [junit4]   2> 2668115 INFO  (qtp1585873013-17700) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[49]} 0 0
   [junit4]   2> 2668117 INFO  (qtp1585873013-17701) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[50]} 0 0
   [junit4]   2> 2668120 INFO  (qtp1585873013-17702) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[51]} 0 0
   [junit4]   2> 2668121 INFO  (qtp1585873013-17703) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[52]} 0 0
   [junit4]   2> 2668123 INFO  (qtp1585873013-17698) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[53]} 0 0
   [junit4]   2> 2668125 INFO  (qtp1585873013-17699) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[54]} 0 0
   [junit4]   2> 2668126 INFO  (qtp1585873013-17700) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[55]} 0 0
   [junit4]   2> 2668128 INFO  (qtp1585873013-17701) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[56]} 0 0
   [junit4]   2> 2668131 INFO  (qtp1585873013-17702) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[57]} 0 0
   [junit4]   2> 2668132 INFO  (qtp1585873013-17703) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[58]} 0 0
   [junit4]   2> 2668134 INFO  (qtp1585873013-17698) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[59]} 0 0
   [junit4]   2> 2668136 INFO  (qtp1585873013-17699) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[60]} 0 0
   [junit4]   2> 2668137 INFO  (qtp1585873013-17700) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[61]} 0 0
   [junit4]   2> 2668139 INFO  (qtp1585873013-17701) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[62]} 0 0
   [junit4]   2> 2668141 INFO  (qtp1585873013-17702) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[63]} 0 0
   [junit4]   2> 2668142 INFO  (qtp1585873013-17703) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[64]} 0 0
   [junit4]   2> 2668144 INFO  (qtp1585873013-17698) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[65]} 0 0
   [junit4]   2> 2668146 INFO  (qtp1585873013-17699) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[66]} 0 0
   [junit4]   2> 2668147 INFO  (qtp1585873013-17700) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[67]} 0 0
   [junit4]   2> 2668149 INFO  (qtp1585873013-17701) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[68]} 0 0
   [junit4]   2> 2668151 INFO  (qtp1585873013-17702) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[69]} 0 0
   [junit4]   2> 2668152 INFO  (qtp1585873013-17703) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[70]} 0 0
   [junit4]   2> 2668154 INFO  (qtp1585873013-17698) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[71]} 0 0
   [junit4]   2> 2668156 INFO  (qtp1585873013-17699) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[72]} 0 0
   [junit4]   2> 2668157 INFO  (qtp1585873013-17700) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[73]} 0 0
   [junit4]   2> 2668159 INFO  (qtp1585873013-17701) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[74]} 0 0
   [junit4]   2> 2668161 INFO  (qtp1585873013-17702) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[75]} 0 0
   [junit4]   2> 2668162 INFO  (qtp1585873013-17703) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[76]} 0 0
   [junit4]   2> 2668164 INFO  (qtp1585873013-17698) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[77]} 0 0
   [junit4]   2> 2668166 INFO  (qtp1585873013-17699) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[78]} 0 0
   [junit4]   2> 2668167 INFO  (qtp1585873013-17700) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[79]} 0 0
   [junit4]   2> 2668170 INFO  (qtp1585873013-17701) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[80]} 0 0
   [junit4]   2> 2668172 INFO  (qtp1585873013-17702) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[81]} 0 0
   [junit4]   2> 2668173 INFO  (qtp1585873013-17703) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[82]} 0 0
   [junit4]   2> 2668175 INFO  (qtp1585873013-17698) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[83]} 0 0
   [junit4]   2> 2668177 INFO  (qtp1585873013-17699) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[84]} 0 0
   [junit4]   2> 2668178 INFO  (qtp1585873013-17700) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[85]} 0 0
   [junit4]   2> 2668180 INFO  (qtp1585873013-17701) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[86]} 0 0
   [junit4]   2> 2668182 INFO  (qtp1585873013-17702) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[87]} 0 0
   [junit4]   2> 2668183 INFO  (qtp1585873013-17703) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[88]} 0 0
   [junit4]   2> 2668185 INFO  (qtp1585873013-17698) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[89]} 0 0
   [junit4]   2> 2668187 INFO  (qtp1585873013-17699) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[90]} 0 0
   [junit4]   2> 2668188 INFO  (qtp1585873013-17700) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[91]} 0 0
   [junit4]   2> 2668190 INFO  (qtp1585873013-17701) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[92]} 0 0
   [junit4]   2> 2668192 INFO  (qtp1585873013-17702) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[93]} 0 0
   [junit4]   2> 2668193 INFO  (qtp1585873013-17703) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[94]} 0 0
   [junit4]   2> 2668195 INFO  (qtp1585873013-17698) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[95]} 0 0
   [junit4]   2> 2668197 INFO  (qtp1585873013-17699) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[96]} 0 0
   [junit4]   2> 2668199 INFO  (qtp1585873013-17700) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[97]} 0 0
   [junit4]   2> 2668201 INFO  (qtp1585873013-17701) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[98]} 0 0
   [junit4]   2> 2668203 INFO  (qtp1585873013-17702) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[99]} 0 0
   [junit4]   2> 2668204 INFO  (qtp1585873013-17703) [    x:collection1] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2668207 INFO  (qtp1585873013-17703) [    x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@10ef7c15 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7c62de0),segFN=segments_1,generation=1}
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@10ef7c15 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7c62de0),segFN=segments_2,generation=2}
   [junit4]   2> 2668207 INFO  (qtp1585873013-17703) [    x:collection1] o.a.s.c.SolrCore newest commit generation = 2
   [junit4]   2> 2668209 INFO  (Thread-6659) [    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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\.\collection1\data\
   [junit4]   2> 2668209 INFO  (qtp1585873013-17703) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@57cf52d7[collection1] main
   [junit4]   2> 2668209 INFO  (qtp1585873013-17703) [    x:collection1] o.a.s.u.UpdateHandler end_commit_flush
   [junit4]   2> 2668209 INFO  (searcherExecutor-7753-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@57cf52d7[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c100)))}
   [junit4]   2> 2668209 INFO  (qtp1585873013-17703) [    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 5
   [junit4]   2> 2668212 INFO  (Thread-6659) [    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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\.\collection1\data\
   [junit4]   2> 2668216 INFO  (qtp1585873013-17698) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2669111 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testBackupOnCommit
   [junit4]   2> 2669112 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] o.e.j.s.ServerConnector Stopped ServerConnector@39be83e5{HTTP/1.1}{127.0.0.1:0}
   [junit4]   2> 2669112 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=14928761
   [junit4]   2> 2669112 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@6d86901e
   [junit4]   2> 2669112 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    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> 2669114 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
   [junit4]   2> 2669114 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 2669114 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
   [junit4]   2> 2669115 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 2669115 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 2669115 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\.\collection1\data\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\.\collection1\data\index;done=false>>]
   [junit4]   2> 2669115 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\.\collection1\data\index
   [junit4]   2> 2669116 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\.\collection1\data\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\.\collection1\data\;done=false>>]
   [junit4]   2> 2669116 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-001\.\collection1\data\
   [junit4]   2> 2669116 INFO  (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[B466C333BCD6B09]) [    x:collection1] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@52f8bdf8{/solr,null,UNAVAILABLE}
   [junit4]   2> 2669120 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    ] o.a.s.SolrTestCaseJ4 ###Starting doTestBackup
   [junit4]   2> 2669137 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\collection1
   [junit4]   2> 2669148 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    ] o.e.j.s.Server jetty-9.2.13.v20150730
   [junit4]   2> 2669150 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1afeddfb{/solr,null,AVAILABLE}
   [junit4]   2> 2669152 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    ] o.e.j.s.ServerConnector Started ServerConnector@4d2321f{HTTP/1.1}{127.0.0.1:57614}
   [junit4]   2> 2669152 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    ] o.e.j.s.Server Started @2680027ms
   [junit4]   2> 2669152 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    ] 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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\collection1\data, hostContext=/solr, hostPort=57614}
   [junit4]   2> 2669152 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a
   [junit4]   2> 2669153 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\'
   [junit4]   2> 2669172 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\solr.xml
   [junit4]   2> 2669178 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    ] o.a.s.c.CoresLocator Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.
   [junit4]   2> 2669178 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    ] o.a.s.c.CoreContainer New CoreContainer 1768052104
   [junit4]   2> 2669178 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\]
   [junit4]   2> 2669179 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    ] o.a.s.c.CoreContainer loading shared library: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\lib
   [junit4]   2> 2669179 WARN  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\lib).
   [junit4]   2> 2669186 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    ] 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> 2669188 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 2669189 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 2669189 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 2669189 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
   [junit4]   2> 2669189 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 2669190 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    ] o.a.s.c.CoresLocator Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.
   [junit4]   2> 2669191 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1, absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\, dataDir=data\}
   [junit4]   2> 2669192 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    ] o.a.s.c.CoresLocator Found core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\
   [junit4]   2> 2669193 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    ] o.a.s.c.CoresLocator Found 1 core definitions
   [junit4]   2> 2669193 INFO  (coreLoadExecutor-7762-thread-1) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\'
   [junit4]   2> 2669194 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    ] o.a.s.s.SolrDispatchFilter user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
   [junit4]   2> 2669194 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 2669213 INFO  (coreLoadExecutor-7762-thread-1) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 2669215 INFO  (coreLoadExecutor-7762-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
   [junit4]   2> 2669219 INFO  (coreLoadExecutor-7762-thread-1) [    ] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 2669220 INFO  (coreLoadExecutor-7762-thread-1) [    ] o.a.s.s.IndexSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\conf\schema.xml
   [junit4]   2> 2669222 INFO  (coreLoadExecutor-7762-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 2669225 INFO  (coreLoadExecutor-7762-thread-1) [    ] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 2669227 INFO  (coreLoadExecutor-7762-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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\conf'
   [junit4]   2> 2669228 INFO  (coreLoadExecutor-7762-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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\
   [junit4]   2> 2669228 INFO  (coreLoadExecutor-7762-thread-1) [    x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 2669228 INFO  (coreLoadExecutor-7762-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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\], dataDir=[null]
   [junit4]   2> 2669228 INFO  (coreLoadExecutor-7762-thread-1) [    x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
   [junit4]   2> 2669228 INFO  (coreLoadExecutor-7762-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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\data\
   [junit4]   2> 2669228 INFO  (coreLoadExecutor-7762-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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\data\index/
   [junit4]   2> 2669229 WARN  (coreLoadExecutor-7762-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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\data\index' doesn't exist. Creating new index...
   [junit4]   2> 2669229 INFO  (coreLoadExecutor-7762-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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\data\index
   [junit4]   2> 2669229 INFO  (coreLoadExecutor-7762-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=20, maxMergeAtOnceExplicit=48, maxMergedSegmentMB=5.9384765625, floorSegmentMB=2.0126953125, forceMergeDeletesPctAllowed=9.374951489217743, segmentsPerTier=45.0, maxCFSSegmentSizeMB=2.162109375, noCFSRatio=0.22244954677596518
   [junit4]   2> 2669229 INFO  (coreLoadExecutor-7762-thread-1) [    x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@140cb177 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@655f4edd),segFN=segments_1,generation=1}
   [junit4]   2> 2669229 INFO  (coreLoadExecutor-7762-thread-1) [    x:collection1] o.a.s.c.SolrCore newest commit generation = 1
   [junit4]   2> 2669230 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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\data\
   [junit4]   2> 2669230 INFO  (coreLoadExecutor-7762-thread-1) [    x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 2669234 INFO  (coreLoadExecutor-7762-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 2669235 INFO  (coreLoadExecutor-7762-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 2669236 INFO  (coreLoadExecutor-7762-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 2669237 INFO  (coreLoadExecutor-7762-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 2669238 INFO  (coreLoadExecutor-7762-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> 2669239 INFO  (coreLoadExecutor-7762-thread-1) [    x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 2669239 INFO  (coreLoadExecutor-7762-thread-1) [    x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
   [junit4]   2> 2669239 INFO  (coreLoadExecutor-7762-thread-1) [    x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
   [junit4]   2> 2669239 INFO  (coreLoadExecutor-7762-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=45, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=95.9736328125, floorSegmentMB=1.8798828125, forceMergeDeletesPctAllowed=18.81393747742557, segmentsPerTier=11.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 2669240 INFO  (coreLoadExecutor-7762-thread-1) [    x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@140cb177 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@655f4edd),segFN=segments_1,generation=1}
   [junit4]   2> 2669240 INFO  (coreLoadExecutor-7762-thread-1) [    x:collection1] o.a.s.c.SolrCore newest commit generation = 1
   [junit4]   2> 2669240 INFO  (coreLoadExecutor-7762-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@75dd798d[collection1] main
   [junit4]   2> 2669241 INFO  (coreLoadExecutor-7762-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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\conf
   [junit4]   2> 2669241 INFO  (coreLoadExecutor-7762-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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\conf}
   [junit4]   2> 2669241 INFO  (coreLoadExecutor-7762-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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\conf
   [junit4]   2> 2669241 INFO  (coreLoadExecutor-7762-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 2669242 INFO  (coreLoadExecutor-7762-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema-replication2.xml:schema.xml
   [junit4]   2> 2669242 INFO  (coreLoadExecutor-7762-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2669242 INFO  (searcherExecutor-7763-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@75dd798d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2669242 INFO  (coreLoadExecutor-7762-thread-1) [    x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 2669677 INFO  (qtp395168789-17719) [    x:collection1] o.a.s.c.SolrCore [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 2669677 INFO  (qtp395168789-17719) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 0
   [junit4]   2> 2669681 INFO  (qtp395168789-17720) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0]} 0 1
   [junit4]   2> 2669683 INFO  (qtp395168789-17721) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1]} 0 0
   [junit4]   2> 2669687 INFO  (qtp395168789-17722) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2]} 0 0
   [junit4]   2> 2669688 INFO  (qtp395168789-17723) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[3]} 0 0
   [junit4]   2> 2669690 INFO  (qtp395168789-17724) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[4]} 0 0
   [junit4]   2> 2669692 INFO  (qtp395168789-17719) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[5]} 0 0
   [junit4]   2> 2669694 INFO  (qtp395168789-17720) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[6]} 0 0
   [junit4]   2> 2669696 INFO  (qtp395168789-17721) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[7]} 0 0
   [junit4]   2> 2669698 INFO  (qtp395168789-17722) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[8]} 0 0
   [junit4]   2> 2669699 INFO  (qtp395168789-17723) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[9]} 0 0
   [junit4]   2> 2669701 INFO  (qtp395168789-17724) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[10]} 0 0
   [junit4]   2> 2669703 INFO  (qtp395168789-17719) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[11]} 0 0
   [junit4]   2> 2669705 INFO  (qtp395168789-17720) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[12]} 0 0
   [junit4]   2> 2669707 INFO  (qtp395168789-17721) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[13]} 0 0
   [junit4]   2> 2669709 INFO  (qtp395168789-17722) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[14]} 0 0
   [junit4]   2> 2669711 INFO  (qtp395168789-17723) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[15]} 0 0
   [junit4]   2> 2669712 INFO  (qtp395168789-17724) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[16]} 0 0
   [junit4]   2> 2669714 INFO  (qtp395168789-17719) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[17]} 0 0
   [junit4]   2> 2669716 INFO  (qtp395168789-17720) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[18]} 0 0
   [junit4]   2> 2669718 INFO  (qtp395168789-17721) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[19]} 0 0
   [junit4]   2> 2669720 INFO  (qtp395168789-17722) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[20]} 0 0
   [junit4]   2> 2669722 INFO  (qtp395168789-17723) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[21]} 0 0
   [junit4]   2> 2669723 INFO  (qtp395168789-17724) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[22]} 0 0
   [junit4]   2> 2669725 INFO  (qtp395168789-17719) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[23]} 0 0
   [junit4]   2> 2669727 INFO  (qtp395168789-17720) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[24]} 0 0
   [junit4]   2> 2669729 INFO  (qtp395168789-17721) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[25]} 0 0
   [junit4]   2> 2669731 INFO  (qtp395168789-17722) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[26]} 0 0
   [junit4]   2> 2669733 INFO  (qtp395168789-17723) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[27]} 0 0
   [junit4]   2> 2669735 INFO  (qtp395168789-17724) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[28]} 0 0
   [junit4]   2> 2669736 INFO  (qtp395168789-17719) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[29]} 0 0
   [junit4]   2> 2669738 INFO  (qtp395168789-17720) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[30]} 0 0
   [junit4]   2> 2669740 INFO  (qtp395168789-17721) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[31]} 0 0
   [junit4]   2> 2669742 INFO  (qtp395168789-17722) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[32]} 0 0
   [junit4]   2> 2669744 INFO  (qtp395168789-17723) [    x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[33]} 0 0
   [junit4]   2> 2669746 INFO  (qtp395168789-17724) [    x:collection1] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2669748 INFO  (qtp395168789-17724) [    x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@140cb177 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@655f4edd),segFN=segments_1,generation=1}
   [junit4]   2> 	commit{dir=MockDirectoryWrapper(RAMDirectory@140cb177 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@655f4edd),segFN=segments_2,generation=2}
   [junit4]   2> 2669749 INFO  (qtp395168789-17724) [    x:collection1] o.a.s.c.SolrCore newest commit generation = 2
   [junit4]   2> 2669751 INFO  (Thread-6674) [    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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\data\
   [junit4]   2> 2669751 INFO  (qtp395168789-17724) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@471a82d1[collection1] main
   [junit4]   2> 2669751 INFO  (qtp395168789-17724) [    x:collection1] o.a.s.u.UpdateHandler end_commit_flush
   [junit4]   2> 2669751 INFO  (searcherExecutor-7763-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@471a82d1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c34)))}
   [junit4]   2> 2669751 INFO  (qtp395168789-17724) [    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 6
   [junit4]   2> 2669755 INFO  (Thread-6674) [    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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\data\
   [junit4]   2> 2669756 INFO  (qtp395168789-17719) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={name=sbs&command=backup} status=0 QTime=2 
   [junit4]   2> 2669756 INFO  (Thread-6675) [    x:collection1] o.a.s.h.SnapShooter Creating backup snapshot sbs at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\data\
   [junit4]   2> 2669759 INFO  (qtp395168789-17720) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2669762 INFO  (Thread-6675) [    x:collection1] o.a.s.h.SnapShooter Done creating backup snapshot: sbs at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\data\
   [junit4]   2> 2670708 INFO  (qtp395168789-17721) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={name=acmsxsm&command=backup} status=0 QTime=1 
   [junit4]   2> 2670708 INFO  (Thread-6676) [    x:collection1] o.a.s.h.SnapShooter Creating backup snapshot acmsxsm at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\data\
   [junit4]   2> 2670712 INFO  (qtp395168789-17722) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2670715 INFO  (Thread-6676) [    x:collection1] o.a.s.h.SnapShooter Done creating backup snapshot: acmsxsm at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\data\
   [junit4]   2> 2671663 INFO  (qtp395168789-17723) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={name=mbaunmr&command=backup} status=0 QTime=4 
   [junit4]   2> 2671664 INFO  (Thread-6677) [    x:collection1] o.a.s.h.SnapShooter Creating backup snapshot mbaunmr at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\data\
   [junit4]   2> 2671666 INFO  (qtp395168789-17724) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2671667 INFO  (Thread-6677) [    x:collection1] o.a.s.h.SnapShooter Done creating backup snapshot: mbaunmr at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\data\
   [junit4]   2> 2672614 INFO  (qtp395168789-17719) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={name=bvgzrogi&command=backup} status=0 QTime=1 
   [junit4]   2> 2672614 INFO  (Thread-6678) [    x:collection1] o.a.s.h.SnapShooter Creating backup snapshot bvgzrogi at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\data\
   [junit4]   2> 2672616 INFO  (qtp395168789-17720) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2672617 INFO  (Thread-6678) [    x:collection1] o.a.s.h.SnapShooter Done creating backup snapshot: bvgzrogi at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\data\
   [junit4]   2> 2673566 INFO  (Thread-6679) [    x:collection1] o.a.s.h.SnapShooter Deleting snapshot: sbs
   [junit4]   2> 2673566 INFO  (qtp395168789-17721) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={name=sbs&command=deletebackup} status=0 QTime=3 
   [junit4]   2> 2673570 INFO  (qtp395168789-17722) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2674517 INFO  (qtp395168789-17723) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={name=acmsxsm&command=deletebackup} status=0 QTime=0 
   [junit4]   2> 2674517 INFO  (Thread-6680) [    x:collection1] o.a.s.h.SnapShooter Deleting snapshot: acmsxsm
   [junit4]   2> 2674518 INFO  (qtp395168789-17724) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2674707 INFO  (qtp395168789-17719) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2674897 INFO  (qtp395168789-17720) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2675086 INFO  (qtp395168789-17721) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2675276 INFO  (qtp395168789-17722) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2675466 INFO  (qtp395168789-17723) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2675657 INFO  (qtp395168789-17724) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2675846 INFO  (qtp395168789-17719) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2676036 INFO  (qtp395168789-17720) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2676227 INFO  (qtp395168789-17721) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2676417 INFO  (qtp395168789-17722) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2676607 INFO  (qtp395168789-17723) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2676797 INFO  (qtp395168789-17724) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2676986 INFO  (qtp395168789-17719) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2677175 INFO  (qtp395168789-17720) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2677366 INFO  (qtp395168789-17721) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2677555 INFO  (qtp395168789-17722) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2677746 INFO  (qtp395168789-17723) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2677935 INFO  (qtp395168789-17724) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2678125 INFO  (qtp395168789-17719) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2678324 INFO  (qtp395168789-17720) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2678534 INFO  (qtp395168789-17721) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2678743 INFO  (qtp395168789-17722) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2678975 INFO  (qtp395168789-17723) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2679184 INFO  (qtp395168789-17724) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2679394 INFO  (qtp395168789-17719) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2679602 INFO  (qtp395168789-17720) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2679810 INFO  (qtp395168789-17721) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2680020 INFO  (qtp395168789-17722) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2680229 INFO  (qtp395168789-17723) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2680439 INFO  (qtp395168789-17724) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2680648 INFO  (qtp395168789-17719) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2680857 INFO  (qtp395168789-17720) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2681067 INFO  (qtp395168789-17721) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2681275 INFO  (qtp395168789-17722) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2681485 INFO  (qtp395168789-17723) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2681694 INFO  (qtp395168789-17724) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2681903 INFO  (qtp395168789-17719) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2682113 INFO  (qtp395168789-17720) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2682322 INFO  (qtp395168789-17721) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2682532 INFO  (qtp395168789-17722) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2682742 INFO  (qtp395168789-17723) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2682951 INFO  (qtp395168789-17724) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2683160 INFO  (qtp395168789-17719) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2683369 INFO  (qtp395168789-17720) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2683579 INFO  (qtp395168789-17721) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2683788 INFO  (qtp395168789-17722) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2683997 INFO  (qtp395168789-17723) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2684206 INFO  (qtp395168789-17724) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2684416 INFO  (qtp395168789-17719) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2684626 INFO  (qtp395168789-17720) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2684835 INFO  (qtp395168789-17721) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2685044 INFO  (qtp395168789-17722) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2685252 INFO  (qtp395168789-17723) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2685461 INFO  (qtp395168789-17724) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2685671 INFO  (qtp395168789-17719) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2685880 INFO  (qtp395168789-17720) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2686089 INFO  (qtp395168789-17721) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2686297 INFO  (qtp395168789-17722) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2686505 INFO  (qtp395168789-17723) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2686714 INFO  (qtp395168789-17724) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2686926 INFO  (qtp395168789-17719) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2687135 INFO  (qtp395168789-17720) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2687343 INFO  (qtp395168789-17721) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2687552 INFO  (qtp395168789-17722) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2687761 INFO  (qtp395168789-17723) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2687971 INFO  (qtp395168789-17724) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2688181 INFO  (qtp395168789-17719) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2688389 INFO  (qtp395168789-17720) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2688598 INFO  (qtp395168789-17721) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2688827 INFO  (qtp395168789-17722) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2689056 INFO  (qtp395168789-17723) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2689285 INFO  (qtp395168789-17724) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2689514 INFO  (qtp395168789-17719) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2689744 INFO  (qtp395168789-17720) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2689974 INFO  (qtp395168789-17721) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2690204 INFO  (qtp395168789-17722) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2690433 INFO  (qtp395168789-17723) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2690663 INFO  (qtp395168789-17724) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2690893 INFO  (qtp395168789-17719) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2691123 INFO  (qtp395168789-17720) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0 
   [junit4]   2> 2691353 INFO  (qtp395168789-17721) [    x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/re

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

 2> 9917603 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
   [junit4]   2> 9917603 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 9917605 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 9917605 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\data\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\data\;done=false>>]
   [junit4]   2> 9917605 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\data\
   [junit4]   2> 9917605 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\data\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\data\index;done=false>>]
   [junit4]   2> 9917605 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001\solr-instance-002\.\collection1\data\index
   [junit4]   2> 9917606 INFO  (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[B466C333BCD6B09]) [    x:collection1] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1afeddfb{/solr,null,UNAVAILABLE}
   [junit4]   2> 9917607 INFO  (SUITE-TestReplicationHandlerBackup-seed#[B466C333BCD6B09]-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\J0\temp\solr.handler.TestReplicationHandlerBackup_B466C333BCD6B09-001
   [junit4]   2> Aug 26, 2015 11:54:56 AM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
   [junit4]   2> INFO: All leaked threads terminated.
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene53): {name=PostingsFormat(name=Memory doPackFST= false), id=PostingsFormat(name=Memory doPackFST= false)}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=true,coord=crazy): {}, locale=ms_MY, timezone=America/Glace_Bay
   [junit4]   2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0_60 (64-bit)/cpus=3,threads=1,free=79096232,total=408420352
   [junit4]   2> NOTE: All tests run in this JVM: [RequestHandlersTest, TestAtomicUpdateErrorCases, HdfsLockFactoryTest, TestNoOpRegenerator, TestCollectionAPI, TestManagedResource, TestSimpleQParserPlugin, TestPivotHelperCode, TestLFUCache, LeaderElectionTest, TestFieldResource, TestGroupingSearch, DirectSolrConnectionTest, CdcrReplicationHandlerTest, TestIndexSearcher, ShardRoutingTest, TestSolrCLIRunExample, SmileWriterTest, TestLazyCores, TestHashPartitioner, TestSimpleTrackingShardHandler, SOLR749Test, DistanceFunctionTest, TestElisionMultitermQuery, ShowFileRequestHandlerTest, UUIDFieldTest, TestCharFilters, TestRandomMergePolicy, AliasIntegrationTest, TestBinaryField, TestSweetSpotSimilarityFactory, TestHighlightDedupGrouping, CacheHeaderTest, TestManagedSchemaFieldResource, TestRandomDVFaceting, TestBM25SimilarityFactory, TestLRUStatsCache, JSONWriterTest, DistributedDebugComponentTest, TestScoreJoinQPNoScore, AddBlockUpdateTest, TestSortByMinMaxFunction, TestHashQParserPlugin, TestCustomDocTransformer, RuleEngineTest, CloudMLTQParserTest, TestSolrConfigHandlerCloud, OutputWriterTest, IndexSchemaRuntimeFieldTest, ExplicitHLLTest, TestStressReorder, DistributedVersionInfoTest, HdfsWriteToMultipleCollectionsTest, TestSchemaResource, CoreAdminRequestStatusTest, HdfsChaosMonkeySafeLeaderTest, TestJmxIntegration, BigEndianAscendingWordDeserializerTest, TestRestManager, FieldAnalysisRequestHandlerTest, DocValuesMissingTest, TestFieldTypeResource, TestRTimerTree, BlockCacheTest, DistributedFacetPivotSmallTest, TestBulkSchemaAPI, TestSchemaVersionResource, UniqFieldsUpdateProcessorFactoryTest, TestArbitraryIndexDir, ExitableDirectoryReaderTest, XmlUpdateRequestHandlerTest, CircularListTest, TestClusterStateMutator, SampleTest, URLClassifyProcessorTest, AsyncMigrateRouteKeyTest, TestExactSharedStatsCache, TestFileDictionaryLookup, TestUpdate, TestCollapseQParserPlugin, TestDynamicLoading, TestAuthorizationFramework, RecoveryAfterSoftCommitTest, TestDistribIDF, MigrateRouteKeyTest, TestPerFieldSimilarity, TestSolrConfigHandler, TestTrackingShardHandlerFactory, NoCacheHeaderTest, PreAnalyzedFieldTest, TestCSVResponseWriter, TestWordDelimiterFilterFactory, HLLUtilTest, TestCollationField, TestCryptoKeys, TestAnalyzeInfixSuggestions, TestCloudPivotFacet, DistributedSpellCheckComponentTest, LeaderInitiatedRecoveryOnCommitTest, TestLRUCache, PeerSyncTest, TestNamedUpdateProcessors, TestCoreContainer, SynonymTokenizerTest, TestRandomRequestDistribution, SimpleCollectionCreateDeleteTest, RequiredFieldsTest, TestBinaryResponseWriter, DistributedIntervalFacetingTest, ScriptEngineTest, AnalysisAfterCoreReloadTest, TestDownShardTolerantSearch, CdcrUpdateLogTest, SyncSliceTest, TestRawResponseWriter, TestFieldCollectionResource, TestCSVLoader, TestCustomSort, TestSurroundQueryParser, TestSmileRequest, TestConfigSets, SolrCoreCheckLockOnStartupTest, TestPhraseSuggestions, TestStressLucene, TestSortingResponseWriter, JavabinLoaderTest, OverseerTest, ChaosMonkeyNothingIsSafeTest, DistanceUnitsTest, DOMUtilTest, TestReplicationHandler, ShardRoutingCustomTest, TestDistributedSearch, JsonLoaderTest, TestPartialUpdateDeduplication, CSVRequestHandlerTest, TestQuerySenderListener, UpdateParamsTest, TestSolrIndexConfig, CopyFieldTest, BadComponentTest, TestStressRecovery, TestDocSet, NumericFieldsTest, TestFuzzyAnalyzedSuggestions, TestPostingsSolrHighlighter, EchoParamsTest, TestIBSimilarityFactory, TestFastWriter, TimeZoneUtilsTest, OpenExchangeRatesOrgProviderTest, TestFastLRUCache, PrimUtilsTest, ClusterStateTest, TestUtils, ZkNodePropsTest, SystemInfoHandlerTest, DistributedMLTComponentTest, TestTolerantSearch, ActionThrottleTest, AssignTest, CdcrReplicationDistributedZkTest, CdcrRequestHandlerTest, CollectionStateFormat2Test, ConcurrentDeleteAndCreateCollectionTest, ConnectionManagerTest, CustomCollectionTest, OverriddenZkACLAndCredentialsProvidersTest, RemoteQueryErrorTest, ReplicationFactorTest, RollingRestartTest, SharedFSAutoReplicaFailoverTest, SolrCloudExampleTest, SolrXmlInZkTest, TestAuthenticationFramework, TestReplicaProperties, TestRequestStatusCollectionAPI, TriLevelCompositeIdRoutingTest, CachingDirectoryFactoryTest, QueryResultKeyTest, TestConfigSetProperties, TestImplicitCoreProperties, TestInfoStreamLogging, TestNRTOpen, TestReloadAndDeleteDocs, TestSolrDynamicMBean, TestSolrXml, TestConfigReload, TestReplicationHandlerBackup]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestReplicationHandlerBackup -Dtests.seed=B466C333BCD6B09 -Dtests.slow=true -Dtests.locale=ms_MY -Dtests.timezone=America/Glace_Bay -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.00s J0 | TestReplicationHandlerBackup (suite) <<<
   [junit4]    > Throwable #1: java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([B466C333BCD6B09]:0)
   [junit4] Completed [540/540] on J0 in 7250.10s, 2 tests, 2 errors <<< FAILURES!

[...truncated 11 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:775: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:719: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:59: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:233: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:514: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1432: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:987: There were test failures: 540 suites, 2136 tests, 1 suite-level error, 1 error, 78 ignored (42 assumptions)

Total time: 181 minutes 9 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



Mime
View raw message