You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2015/06/05 06:26:08 UTC
[JENKINS] Lucene-Solr-trunk-Windows (32bit/jdk1.8.0_45) - Build #
4893 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/4893/
Java: 32bit/jdk1.8.0_45 -client -XX:+UseConcMarkSweepGC
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([2D36CC422510AB74]: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([2D36CC422510AB74]:0)
Build Log:
[...truncated 10913 lines...]
[junit4] Suite: org.apache.solr.handler.TestReplicationHandlerBackup
[junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\init-core-data-001
[junit4] 2> 742442 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testBackupOnCommit
[junit4] 2> 742443 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\collection1
[junit4] 2> 742457 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] o.e.j.s.Server jetty-9.2.10.v20150310
[junit4] 2> 742461 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1769ef3{/solr,null,AVAILABLE}
[junit4] 2> 742466 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] o.e.j.s.ServerConnector Started ServerConnector@1444c59{HTTP/1.1}{127.0.0.1:50431}
[junit4] 2> 742466 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] o.e.j.s.Server Started @745581ms
[junit4] 2> 742467 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\collection1\data, hostContext=/solr, hostPort=50431}
[junit4] 2> 742467 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@e2f2a
[junit4] 2> 742467 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\'
[junit4] 2> 742491 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\solr.xml
[junit4] 2> 742503 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\.
[junit4] 2> 742503 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] o.a.s.c.CoreContainer New CoreContainer 22905125
[junit4] 2> 742503 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\]
[junit4] 2> 742503 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] o.a.s.c.CoreContainer loading shared library: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\lib
[junit4] 2> 742503 WARN (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\lib).
[junit4] 2> 742512 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] 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> 742512 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 742513 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 742513 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 742513 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 742514 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] o.a.s.c.CoresLocator Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\.
[junit4] 2> 742515 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig.xml, instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\.\collection1, loadOnStartup=true, absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\.\collection1\, schema=schema.xml, transient=false, dataDir=data\}
[junit4] 2> 742516 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] o.a.s.c.CoresLocator Found core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\.\collection1\
[junit4] 2> 742517 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] o.a.s.c.CoresLocator Found 1 core definitions
[junit4] 2> 742517 INFO (coreLoadExecutor-2598-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\.\collection1\'
[junit4] 2> 742518 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] o.a.s.s.SolrDispatchFilter user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1
[junit4] 2> 742519 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 742543 INFO (coreLoadExecutor-2598-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 742547 INFO (coreLoadExecutor-2598-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 742558 INFO (coreLoadExecutor-2598-thread-1) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml
[junit4] 2> 742558 INFO (coreLoadExecutor-2598-thread-1) [ ] o.a.s.s.IndexSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\.\collection1\conf\schema.xml
[junit4] 2> 742561 INFO (coreLoadExecutor-2598-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 742565 INFO (coreLoadExecutor-2598-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 742565 INFO (coreLoadExecutor-2598-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\.\collection1\
[junit4] 2> 742566 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 742566 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\.\collection1\], dataDir=[null]
[junit4] 2> 742566 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
[junit4] 2> 742566 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\.\collection1\data\
[junit4] 2> 742567 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\.\collection1\data\index/
[junit4] 2> 742567 WARN (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\.\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 742567 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\.\collection1\data\index
[junit4] 2> 742568 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=46, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5991791144248316]
[junit4] 2> 742568 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@954de7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8d12b0),segFN=segments_1,generation=1}
[junit4] 2> 742568 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 742570 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\.\collection1\data\
[junit4] 2> 742571 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 742574 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 742575 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 742577 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 742578 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 742580 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy
[junit4] 2> 742580 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,lazy,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,defaults,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
[junit4] 2> 742581 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 742582 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
[junit4] 2> 742582 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
[junit4] 2> 742582 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=2071340939, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 742582 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@954de7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8d12b0),segFN=segments_1,generation=1}
[junit4] 2> 742582 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 742583 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@33cd83[collection1] main
[junit4] 2> 742583 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\.\collection1\conf
[junit4] 2> 742583 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\.\collection1\conf}
[junit4] 2> 742584 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\.\collection1\conf
[junit4] 2> 742584 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 742585 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema-replication2.xml:schema.xml
[junit4] 2> 742585 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 742585 INFO (searcherExecutor-2599-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@33cd83[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 742585 INFO (coreLoadExecutor-2598-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 742850 INFO (qtp4539-4592) [ x:collection1] o.a.s.c.SolrCore [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 742850 INFO (qtp4539-4592) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 0
[junit4] 2> 742855 INFO (qtp4539-4593) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0]} 0 2
[junit4] 2> 742858 INFO (qtp4539-4594) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1]} 0 1
[junit4] 2> 742860 INFO (qtp4539-4595) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2]} 0 0
[junit4] 2> 742863 INFO (qtp4539-4596) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[3]} 0 1
[junit4] 2> 742865 INFO (qtp4539-4597) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[4]} 0 0
[junit4] 2> 742867 INFO (qtp4539-4592) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[5]} 0 0
[junit4] 2> 742869 INFO (qtp4539-4593) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[6]} 0 0
[junit4] 2> 742871 INFO (qtp4539-4594) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[7]} 0 1
[junit4] 2> 742874 INFO (qtp4539-4595) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[8]} 0 0
[junit4] 2> 742875 INFO (qtp4539-4596) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[9]} 0 0
[junit4] 2> 742877 INFO (qtp4539-4597) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[10]} 0 0
[junit4] 2> 742879 INFO (qtp4539-4592) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[11]} 0 0
[junit4] 2> 742882 INFO (qtp4539-4593) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[12]} 0 0
[junit4] 2> 742884 INFO (qtp4539-4594) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[13]} 0 0
[junit4] 2> 742887 INFO (qtp4539-4595) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[14]} 0 1
[junit4] 2> 742889 INFO (qtp4539-4596) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[15]} 0 0
[junit4] 2> 742891 INFO (qtp4539-4597) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[16]} 0 0
[junit4] 2> 742894 INFO (qtp4539-4592) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[17]} 0 0
[junit4] 2> 742896 INFO (qtp4539-4593) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[18]} 0 0
[junit4] 2> 742898 INFO (qtp4539-4594) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[19]} 0 0
[junit4] 2> 742900 INFO (qtp4539-4595) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[20]} 0 0
[junit4] 2> 742903 INFO (qtp4539-4596) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[21]} 0 1
[junit4] 2> 742905 INFO (qtp4539-4597) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[22]} 0 1
[junit4] 2> 742908 INFO (qtp4539-4592) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[23]} 0 1
[junit4] 2> 742909 INFO (qtp4539-4593) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[24]} 0 0
[junit4] 2> 742911 INFO (qtp4539-4594) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[25]} 0 0
[junit4] 2> 742913 INFO (qtp4539-4595) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[26]} 0 0
[junit4] 2> 742915 INFO (qtp4539-4596) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[27]} 0 0
[junit4] 2> 742916 INFO (qtp4539-4597) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[28]} 0 0
[junit4] 2> 742919 INFO (qtp4539-4592) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[29]} 0 1
[junit4] 2> 742920 INFO (qtp4539-4593) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[30]} 0 0
[junit4] 2> 742923 INFO (qtp4539-4594) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[31]} 0 1
[junit4] 2> 742924 INFO (qtp4539-4595) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[32]} 0 0
[junit4] 2> 742926 INFO (qtp4539-4596) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[33]} 0 0
[junit4] 2> 742928 INFO (qtp4539-4597) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[34]} 0 0
[junit4] 2> 742930 INFO (qtp4539-4592) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[35]} 0 0
[junit4] 2> 742933 INFO (qtp4539-4593) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[36]} 0 0
[junit4] 2> 742935 INFO (qtp4539-4594) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[37]} 0 0
[junit4] 2> 742937 INFO (qtp4539-4595) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[38]} 0 0
[junit4] 2> 742938 INFO (qtp4539-4596) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[39]} 0 0
[junit4] 2> 742940 INFO (qtp4539-4597) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[40]} 0 0
[junit4] 2> 742942 INFO (qtp4539-4592) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[41]} 0 0
[junit4] 2> 742944 INFO (qtp4539-4593) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[42]} 0 0
[junit4] 2> 742946 INFO (qtp4539-4594) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[43]} 0 0
[junit4] 2> 742949 INFO (qtp4539-4595) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[44]} 0 0
[junit4] 2> 742951 INFO (qtp4539-4596) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[45]} 0 1
[junit4] 2> 742952 INFO (qtp4539-4597) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[46]} 0 0
[junit4] 2> 742954 INFO (qtp4539-4592) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[47]} 0 0
[junit4] 2> 742956 INFO (qtp4539-4593) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[48]} 0 0
[junit4] 2> 742959 INFO (qtp4539-4594) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[49]} 0 1
[junit4] 2> 742960 INFO (qtp4539-4595) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[50]} 0 0
[junit4] 2> 742962 INFO (qtp4539-4596) [ x:collection1] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 742966 INFO (qtp4539-4596) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@954de7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8d12b0),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@954de7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8d12b0),segFN=segments_2,generation=2}
[junit4] 2> 742966 INFO (qtp4539-4596) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 2
[junit4] 2> 742973 INFO (Thread-2104) [ x:collection1] o.a.s.h.SnapShooter Creating backup snapshot <not named> at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\.\collection1\data\
[junit4] 2> 742974 INFO (qtp4539-4596) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@14ae7ca[collection1] main
[junit4] 2> 742974 INFO (qtp4539-4596) [ x:collection1] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 742974 INFO (searcherExecutor-2599-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@14ae7ca[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c51)))}
[junit4] 2> 742974 INFO (qtp4539-4596) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 12
[junit4] 2> 742977 INFO (Thread-2104) [ x:collection1] o.a.s.h.SnapShooter Done creating backup snapshot: <not named> at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\.\collection1\data\
[junit4] 2> 742983 INFO (qtp4539-4597) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 743632 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testBackupOnCommit
[junit4] 2> 743634 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@1444c59{HTTP/1.1}{127.0.0.1:0}
[junit4] 2> 743634 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=22905125
[junit4] 2> 743634 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@c88f7d
[junit4] 2> 743635 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ 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=51,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
[junit4] 2> 743635 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 743635 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 743635 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
[junit4] 2> 743637 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
[junit4] 2> 743637 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 743637 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\.\collection1\data\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\.\collection1\data\;done=false>>]
[junit4] 2> 743637 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\.\collection1\data\
[junit4] 2> 743637 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\.\collection1\data\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\.\collection1\data\index;done=false>>]
[junit4] 2> 743637 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-001\.\collection1\data\index
[junit4] 2> 743638 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[2D36CC422510AB74]) [ x:collection1] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1769ef3{/solr,null,UNAVAILABLE}
[junit4] 2> 743641 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] o.a.s.SolrTestCaseJ4 ###Starting doTestBackup
[junit4] 2> 743642 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\collection1
[junit4] 2> 743650 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] o.e.j.s.Server jetty-9.2.10.v20150310
[junit4] 2> 743652 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@d07de6{/solr,null,AVAILABLE}
[junit4] 2> 743654 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] o.e.j.s.ServerConnector Started ServerConnector@1f51034{HTTP/1.1}{127.0.0.1:50435}
[junit4] 2> 743654 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] o.e.j.s.Server Started @747423ms
[junit4] 2> 743654 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\collection1\data, hostContext=/solr, hostPort=50435}
[junit4] 2> 743655 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@e2f2a
[junit4] 2> 743655 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\'
[junit4] 2> 743682 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\solr.xml
[junit4] 2> 743688 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.
[junit4] 2> 743688 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] o.a.s.c.CoreContainer New CoreContainer 20451910
[junit4] 2> 743688 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\]
[junit4] 2> 743689 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] o.a.s.c.CoreContainer loading shared library: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\lib
[junit4] 2> 743689 WARN (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\lib).
[junit4] 2> 743699 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] 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> 743703 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 743704 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 743704 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 743704 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 743705 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] o.a.s.c.CoresLocator Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.
[junit4] 2> 743708 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig.xml, instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1, loadOnStartup=true, absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\, schema=schema.xml, transient=false, dataDir=data\}
[junit4] 2> 743708 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] o.a.s.c.CoresLocator Found core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\
[junit4] 2> 743709 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] o.a.s.c.CoresLocator Found 1 core definitions
[junit4] 2> 743710 INFO (coreLoadExecutor-2608-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\'
[junit4] 2> 743710 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] o.a.s.s.SolrDispatchFilter user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1
[junit4] 2> 743710 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 743732 INFO (coreLoadExecutor-2608-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 743737 INFO (coreLoadExecutor-2608-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 743743 INFO (coreLoadExecutor-2608-thread-1) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml
[junit4] 2> 743743 INFO (coreLoadExecutor-2608-thread-1) [ ] o.a.s.s.IndexSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\conf\schema.xml
[junit4] 2> 743745 INFO (coreLoadExecutor-2608-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 743749 INFO (coreLoadExecutor-2608-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 743749 INFO (coreLoadExecutor-2608-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\
[junit4] 2> 743749 INFO (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 743749 INFO (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\], dataDir=[null]
[junit4] 2> 743749 INFO (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
[junit4] 2> 743749 INFO (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\data\
[junit4] 2> 743750 INFO (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\data\index/
[junit4] 2> 743750 WARN (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 743750 INFO (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\data\index
[junit4] 2> 743751 INFO (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=46, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5991791144248316]
[junit4] 2> 743751 INFO (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@98b2b4 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e97735),segFN=segments_1,generation=1}
[junit4] 2> 743751 INFO (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 743752 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\data\
[junit4] 2> 743753 INFO (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 743758 INFO (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 743760 INFO (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 743760 INFO (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 743761 INFO (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 743763 INFO (coreLoadExecutor-2608-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> 743763 INFO (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 743764 INFO (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
[junit4] 2> 743764 INFO (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
[junit4] 2> 743765 INFO (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=2071340939, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 743765 INFO (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@98b2b4 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e97735),segFN=segments_1,generation=1}
[junit4] 2> 743765 INFO (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 743765 INFO (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@183f8e0[collection1] main
[junit4] 2> 743765 INFO (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\conf
[junit4] 2> 743766 INFO (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\conf}
[junit4] 2> 743766 INFO (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\conf
[junit4] 2> 743766 INFO (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 743766 INFO (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema-replication2.xml:schema.xml
[junit4] 2> 743766 INFO (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 743766 INFO (searcherExecutor-2609-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@183f8e0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 743766 INFO (coreLoadExecutor-2608-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 744036 INFO (qtp22245877-4612) [ x:collection1] o.a.s.c.SolrCore [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 744036 INFO (qtp22245877-4612) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 0
[junit4] 2> 744040 INFO (qtp22245877-4613) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0]} 0 2
[junit4] 2> 744042 INFO (qtp22245877-4614) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1]} 0 1
[junit4] 2> 744043 INFO (qtp22245877-4615) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2]} 0 0
[junit4] 2> 744046 INFO (qtp22245877-4616) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[3]} 0 1
[junit4] 2> 744047 INFO (qtp22245877-4617) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[4]} 0 0
[junit4] 2> 744049 INFO (qtp22245877-4612) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[5]} 0 0
[junit4] 2> 744051 INFO (qtp22245877-4613) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[6]} 0 0
[junit4] 2> 744053 INFO (qtp22245877-4614) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[7]} 0 0
[junit4] 2> 744057 INFO (qtp22245877-4615) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[8]} 0 2
[junit4] 2> 744058 INFO (qtp22245877-4616) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[9]} 0 0
[junit4] 2> 744060 INFO (qtp22245877-4617) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[10]} 0 0
[junit4] 2> 744063 INFO (qtp22245877-4612) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[11]} 0 1
[junit4] 2> 744065 INFO (qtp22245877-4613) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[12]} 0 0
[junit4] 2> 744067 INFO (qtp22245877-4614) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[13]} 0 0
[junit4] 2> 744069 INFO (qtp22245877-4615) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[14]} 0 0
[junit4] 2> 744072 INFO (qtp22245877-4616) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[15]} 0 1
[junit4] 2> 744073 INFO (qtp22245877-4617) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[16]} 0 0
[junit4] 2> 744075 INFO (qtp22245877-4612) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[17]} 0 0
[junit4] 2> 744078 INFO (qtp22245877-4613) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[18]} 0 1
[junit4] 2> 744080 INFO (qtp22245877-4614) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[19]} 0 0
[junit4] 2> 744082 INFO (qtp22245877-4615) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[20]} 0 0
[junit4] 2> 744084 INFO (qtp22245877-4616) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[21]} 0 0
[junit4] 2> 744086 INFO (qtp22245877-4617) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[22]} 0 0
[junit4] 2> 744087 INFO (qtp22245877-4612) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[23]} 0 0
[junit4] 2> 744090 INFO (qtp22245877-4613) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[24]} 0 1
[junit4] 2> 744092 INFO (qtp22245877-4614) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[25]} 0 0
[junit4] 2> 744095 INFO (qtp22245877-4615) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[26]} 0 1
[junit4] 2> 744099 INFO (qtp22245877-4616) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[27]} 0 0
[junit4] 2> 744103 INFO (qtp22245877-4617) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[28]} 0 0
[junit4] 2> 744106 INFO (qtp22245877-4612) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[29]} 0 1
[junit4] 2> 744108 INFO (qtp22245877-4613) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[30]} 0 1
[junit4] 2> 744110 INFO (qtp22245877-4614) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[31]} 0 0
[junit4] 2> 744113 INFO (qtp22245877-4615) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[32]} 0 1
[junit4] 2> 744115 INFO (qtp22245877-4616) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[33]} 0 0
[junit4] 2> 744117 INFO (qtp22245877-4617) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[34]} 0 0
[junit4] 2> 744120 INFO (qtp22245877-4612) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[35]} 0 0
[junit4] 2> 744122 INFO (qtp22245877-4613) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[36]} 0 0
[junit4] 2> 744123 INFO (qtp22245877-4614) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[37]} 0 0
[junit4] 2> 744127 INFO (qtp22245877-4615) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[38]} 0 1
[junit4] 2> 744128 INFO (qtp22245877-4616) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[39]} 0 0
[junit4] 2> 744130 INFO (qtp22245877-4617) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[40]} 0 0
[junit4] 2> 744133 INFO (qtp22245877-4612) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[41]} 0 1
[junit4] 2> 744135 INFO (qtp22245877-4613) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[42]} 0 0
[junit4] 2> 744138 INFO (qtp22245877-4614) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[43]} 0 1
[junit4] 2> 744139 INFO (qtp22245877-4615) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[44]} 0 0
[junit4] 2> 744142 INFO (qtp22245877-4616) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[45]} 0 0
[junit4] 2> 744144 INFO (qtp22245877-4617) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[46]} 0 0
[junit4] 2> 744146 INFO (qtp22245877-4612) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[47]} 0 0
[junit4] 2> 744149 INFO (qtp22245877-4613) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[48]} 0 0
[junit4] 2> 744152 INFO (qtp22245877-4614) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[49]} 0 1
[junit4] 2> 744153 INFO (qtp22245877-4615) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[50]} 0 0
[junit4] 2> 744156 INFO (qtp22245877-4616) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[51]} 0 1
[junit4] 2> 744157 INFO (qtp22245877-4617) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[52]} 0 0
[junit4] 2> 744161 INFO (qtp22245877-4612) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[53]} 0 1
[junit4] 2> 744162 INFO (qtp22245877-4613) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[54]} 0 0
[junit4] 2> 744164 INFO (qtp22245877-4614) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[55]} 0 0
[junit4] 2> 744167 INFO (qtp22245877-4615) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[56]} 0 1
[junit4] 2> 744169 INFO (qtp22245877-4616) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[57]} 0 1
[junit4] 2> 744171 INFO (qtp22245877-4617) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[58]} 0 0
[junit4] 2> 744173 INFO (qtp22245877-4612) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[59]} 0 0
[junit4] 2> 744175 INFO (qtp22245877-4613) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[60]} 0 0
[junit4] 2> 744177 INFO (qtp22245877-4614) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[61]} 0 0
[junit4] 2> 744180 INFO (qtp22245877-4615) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[62]} 0 0
[junit4] 2> 744182 INFO (qtp22245877-4616) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[63]} 0 0
[junit4] 2> 744184 INFO (qtp22245877-4617) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[64]} 0 0
[junit4] 2> 744186 INFO (qtp22245877-4612) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[65]} 0 0
[junit4] 2> 744188 INFO (qtp22245877-4613) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[66]} 0 0
[junit4] 2> 744190 INFO (qtp22245877-4614) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[67]} 0 0
[junit4] 2> 744191 INFO (qtp22245877-4615) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[68]} 0 0
[junit4] 2> 744193 INFO (qtp22245877-4616) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[69]} 0 0
[junit4] 2> 744195 INFO (qtp22245877-4617) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[70]} 0 0
[junit4] 2> 744198 INFO (qtp22245877-4612) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[71]} 0 1
[junit4] 2> 744199 INFO (qtp22245877-4613) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[72]} 0 0
[junit4] 2> 744201 INFO (qtp22245877-4614) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[73]} 0 0
[junit4] 2> 744203 INFO (qtp22245877-4615) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[74]} 0 0
[junit4] 2> 744205 INFO (qtp22245877-4616) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[75]} 0 0
[junit4] 2> 744208 INFO (qtp22245877-4617) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[76]} 0 1
[junit4] 2> 744209 INFO (qtp22245877-4612) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[77]} 0 0
[junit4] 2> 744211 INFO (qtp22245877-4613) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[78]} 0 0
[junit4] 2> 744213 INFO (qtp22245877-4614) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[79]} 0 0
[junit4] 2> 744215 INFO (qtp22245877-4615) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[80]} 0 0
[junit4] 2> 744217 INFO (qtp22245877-4616) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[81]} 0 0
[junit4] 2> 744219 INFO (qtp22245877-4617) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[82]} 0 0
[junit4] 2> 744221 INFO (qtp22245877-4612) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[83]} 0 0
[junit4] 2> 744222 INFO (qtp22245877-4613) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[84]} 0 0
[junit4] 2> 744224 INFO (qtp22245877-4614) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[85]} 0 0
[junit4] 2> 744226 INFO (qtp22245877-4615) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[86]} 0 0
[junit4] 2> 744228 INFO (qtp22245877-4616) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[87]} 0 0
[junit4] 2> 744230 INFO (qtp22245877-4617) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[88]} 0 0
[junit4] 2> 744232 INFO (qtp22245877-4612) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[89]} 0 0
[junit4] 2> 744234 INFO (qtp22245877-4613) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[90]} 0 0
[junit4] 2> 744236 INFO (qtp22245877-4614) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[91]} 0 0
[junit4] 2> 744238 INFO (qtp22245877-4615) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[92]} 0 0
[junit4] 2> 744240 INFO (qtp22245877-4616) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[93]} 0 0
[junit4] 2> 744242 INFO (qtp22245877-4617) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[94]} 0 0
[junit4] 2> 744244 INFO (qtp22245877-4612) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[95]} 0 0
[junit4] 2> 744246 INFO (qtp22245877-4613) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[96]} 0 0
[junit4] 2> 744248 INFO (qtp22245877-4614) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[97]} 0 0
[junit4] 2> 744250 INFO (qtp22245877-4615) [ x:collection1] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 744253 INFO (qtp22245877-4615) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@98b2b4 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e97735),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@98b2b4 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e97735),segFN=segments_2,generation=2}
[junit4] 2> 744255 INFO (qtp22245877-4615) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 2
[junit4] 2> 744257 INFO (Thread-2118) [ x:collection1] o.a.s.h.SnapShooter Creating backup snapshot <not named> at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\data\
[junit4] 2> 744258 INFO (qtp22245877-4615) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@b736ce[collection1] main
[junit4] 2> 744259 INFO (qtp22245877-4615) [ x:collection1] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 744259 INFO (searcherExecutor-2609-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@b736ce[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c98)))}
[junit4] 2> 744260 INFO (qtp22245877-4615) [ 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 10
[junit4] 2> 744260 INFO (Thread-2118) [ x:collection1] o.a.s.h.SnapShooter Done creating backup snapshot: <not named> at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\data\
[junit4] 2> 744268 INFO (qtp22245877-4616) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={name=gdjhpjiephxdgt&command=backup} status=0 QTime=2
[junit4] 2> 744268 INFO (Thread-2119) [ x:collection1] o.a.s.h.SnapShooter Creating backup snapshot gdjhpjiephxdgt at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\data\
[junit4] 2> 744272 INFO (Thread-2119) [ x:collection1] o.a.s.h.SnapShooter Done creating backup snapshot: gdjhpjiephxdgt at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\data\
[junit4] 2> 744274 INFO (qtp22245877-4617) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 744925 INFO (qtp22245877-4612) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={name=yaliggcrvnkp&command=backup} status=0 QTime=1
[junit4] 2> 744925 INFO (Thread-2120) [ x:collection1] o.a.s.h.SnapShooter Creating backup snapshot yaliggcrvnkp at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\data\
[junit4] 2> 744927 INFO (qtp22245877-4613) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 744929 INFO (Thread-2120) [ x:collection1] o.a.s.h.SnapShooter Done creating backup snapshot: yaliggcrvnkp at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\data\
[junit4] 2> 745578 INFO (qtp22245877-4614) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={name=miwgodc&command=backup} status=0 QTime=2
[junit4] 2> 745578 INFO (Thread-2121) [ x:collection1] o.a.s.h.SnapShooter Creating backup snapshot miwgodc at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\data\
[junit4] 2> 745580 INFO (qtp22245877-4615) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 745583 INFO (Thread-2121) [ x:collection1] o.a.s.h.SnapShooter Done creating backup snapshot: miwgodc at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\data\
[junit4] 2> 746230 INFO (qtp22245877-4616) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={name=fjxppkzvpvid&command=backup} status=0 QTime=1
[junit4] 2> 746230 INFO (Thread-2122) [ x:collection1] o.a.s.h.SnapShooter Creating backup snapshot fjxppkzvpvid at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\data\
[junit4] 2> 746233 INFO (qtp22245877-4617) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 746237 INFO (Thread-2122) [ x:collection1] o.a.s.h.SnapShooter Done creating backup snapshot: fjxppkzvpvid at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\data\
[junit4] 2> 746885 INFO (qtp22245877-4612) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={name=gdjhpjiephxdgt&command=deletebackup} status=0 QTime=3
[junit4] 2> 746885 INFO (Thread-2123) [ x:collection1] o.a.s.h.SnapShooter Deleting snapshot: gdjhpjiephxdgt
[junit4] 2> 746887 INFO (qtp22245877-4612) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 747536 INFO (qtp22245877-4613) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={name=yaliggcrvnkp&command=deletebackup} status=0 QTime=2
[junit4] 2> 747536 INFO (Thread-2124) [ x:collection1] o.a.s.h.SnapShooter Deleting snapshot: yaliggcrvnkp
[junit4] 2> 747537 INFO (qtp22245877-4614) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 747667 INFO (qtp22245877-4615) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 747799 INFO (qtp22245877-4616) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 747930 INFO (qtp22245877-4617) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=2
[junit4] 2> 748060 INFO (qtp22245877-4612) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 748190 INFO (qtp22245877-4613) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 748321 INFO (qtp22245877-4614) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 748451 INFO (qtp22245877-4615) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 748571 INFO (qtp22245877-4616) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 748689 INFO (qtp22245877-4617) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 748807 INFO (qtp22245877-4612) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 748924 INFO (qtp22245877-4613) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 749041 INFO (qtp22245877-4614) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 749159 INFO (qtp22245877-4615) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 749276 INFO (qtp22245877-4616) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 749394 INFO (qtp22245877-4617) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 749512 INFO (qtp22245877-4612) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 749629 INFO (qtp22245877-4613) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 749747 INFO (qtp22245877-4614) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 749864 INFO (qtp22245877-4615) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 749982 INFO (qtp22245877-4616) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 750100 INFO (qtp22245877-4617) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 750218 INFO (qtp22245877-4612) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 750335 INFO (qtp22245877-4613) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 750453 INFO (qtp22245877-4614) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 750575 INFO (qtp22245877-4615) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=4
[junit4] 2> 750693 INFO (qtp22245877-4616) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 750810 INFO (qtp22245877-4617) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 750928 INFO (qtp22245877-4612) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 751046 INFO (qtp22245877-4613) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 751164 INFO (qtp22245877-4614) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 751281 INFO (qtp22245877-4615) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 751400 INFO (qtp22245877-4616) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 751517 INFO (qtp22245877-4617) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 751635 INFO (qtp22245877-4612) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 751753 INFO (qtp22245877-4613) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 751870 INFO (qtp22245877-4614) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 751988 INFO (qtp22245877-4615) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 752105 INFO (qtp22245877-4616) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 752223 INFO (qtp22245877-4617) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 752341 INFO (qtp22245877-4612) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 752460 INFO (qtp22245877-4613) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 752579 INFO (qtp22245877-4614) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 752697 INFO (qtp22245877-4615) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 752815 INFO (qtp22245877-4616) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 752932 INFO (qtp22245877-4617) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 753050 INFO (qtp22245877-4612) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 753169 INFO (qtp22245877-4613) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 753287 INFO (qtp22245877-4614) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 753406 INFO (qtp22245877-4615) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 753524 INFO (qtp22245877-4616) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 753642 INFO (qtp22245877-4617) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 753760 INFO (qtp22245877-4612) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 753878 INFO (qtp22245877-4613) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 753997 INFO (qtp22245877-4614) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 754115 INFO (qtp22245877-4615) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 754232 INFO (qtp22245877-4616) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 754356 INFO (qtp22245877-4617) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 754485 INFO (qtp22245877-4612) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 754614 INFO (qtp22245877-4613) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 754744 INFO (qtp22245877-4614) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 754873 INFO (qtp22245877-4615) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 755002 INFO (qtp22245877-4616) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 755133 INFO (qtp22245877-4617) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 755264 INFO (qtp22245877-4612) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 755394 INFO (qtp22245877-4613) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 755523 INFO (qtp22245877-4614) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 755653 INFO (qtp22245877-4615) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 755782 INFO (qtp22245877-4616) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 755911 INFO (qtp22245877-4617) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 756041 INFO (qtp22245877-4612) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 756170 INFO (qtp22245877-4613) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 756299 INFO (qtp22245877-4614) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 756428 INFO (qtp22245877-4615) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 756558 INFO (qtp22245877-4616) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 756687 INFO (qtp22245877-4617) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 756817 INFO (qtp22245877-4612) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 756947 INFO (qtp22245877-4613) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=2
[junit4] 2> 757076 INFO (qtp22245877-4614) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={c
[...truncated too long message...]
854, state=TIMED_WAITING, group=TGRP-TestReplicationHandlerBackup]
[junit4] 2> 7) Thread[id=4621, name=Thread-2114, state=WAITING, group=TGRP-TestReplicationHandlerBackup]
[junit4] 2> 8) Thread[id=4610, name=qtp22245877-4610-selector-ServerConnectorManager@172c490/0, state=RUNNABLE, group=TGRP-TestReplicationHandlerBackup]
[junit4] 2> 9) Thread[id=4612, name=qtp22245877-4612, state=TIMED_WAITING, group=TGRP-TestReplicationHandlerBackup]
[junit4] 2> 10) Thread[id=4614, name=qtp22245877-4614, state=TIMED_WAITING, group=TGRP-TestReplicationHandlerBackup]
[junit4] 2> 11) Thread[id=4613, name=qtp22245877-4613, state=TIMED_WAITING, group=TGRP-TestReplicationHandlerBackup]
[junit4] 2> 12) Thread[id=4611, name=qtp22245877-4611-acceptor-0@a83102-ServerConnector@1f51034{HTTP/1.1}{127.0.0.1:50435}, state=RUNNABLE, group=TGRP-TestReplicationHandlerBackup]
[junit4] 2> 13) Thread[id=4619, name=org.eclipse.jetty.server.session.HashSessionManager@1432c25Timer, state=TIMED_WAITING, group=TGRP-TestReplicationHandlerBackup]
[junit4] 2> 14) Thread[id=4618, name=Scheduler-2664030, state=TIMED_WAITING, group=TGRP-TestReplicationHandlerBackup]
[junit4] 2> 8026353 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] o.a.s.SolrTestCaseJ4 ###Ending doTestBackup
[junit4] 2> 8026357 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@1f51034{HTTP/1.1}{127.0.0.1:0}
[junit4] 2> 8026358 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=20451910
[junit4] 2> 8026358 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@7c080f
[junit4] 2> 8026359 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ 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=98,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
[junit4] 2> 8026361 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 8026361 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 8026361 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
[junit4] 2> 8026362 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
[junit4] 2> 8026362 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 8026363 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\data\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\data\index;done=false>>]
[junit4] 2> 8026363 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\data\index
[junit4] 2> 8026363 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\data\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\data\;done=false>>]
[junit4] 2> 8026364 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001\solr-instance-002\.\collection1\data\
[junit4] 2> 8026364 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[2D36CC422510AB74]) [ x:collection1] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@d07de6{/solr,null,UNAVAILABLE}
[junit4] 2> 8026367 INFO (SUITE-TestReplicationHandlerBackup-seed#[2D36CC422510AB74]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup 2D36CC422510AB74-001
[junit4] 2> Jun 05, 2015 4:15:25 AM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: All leaked threads terminated.
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {name=BlockTreeOrds(blocksize=128), id=BlockTreeOrds(blocksize=128)}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=false,coord=yes): {}, locale=de_CH, timezone=Asia/Oral
[junit4] 2> NOTE: Windows 7 6.1 x86/Oracle Corporation 1.8.0_45 (32-bit)/cpus=3,threads=1,free=109550392,total=218615808
[junit4] 2> NOTE: All tests run in this JVM: [TestQuerySenderListener, TestLuceneMatchVersion, SimplePostToolTest, FileUtilsTest, SpatialHeatmapFacetsTest, CloudMLTQParserTest, PolyFieldTest, TestComplexPhraseQParserPlugin, AliasIntegrationTest, LeaderFailoverAfterPartitionTest, BlockDirectoryTest, TestHighFrequencyDictionaryFactory, DistributedQueueTest, TestConfig, BasicZkTest, SpatialRPTFieldTypeTest, TestSolrQueryParserDefaultOperatorResource, TestUtils, MergeStrategyTest, OverseerCollectionProcessorTest, TestDefaultStatsCache, TestFiltering, UpdateParamsTest, TestDistribDocBasedVersion, ParsingFieldUpdateProcessorsTest, DistributedDebugComponentTest, TestFileDictionaryLookup, QueryParsingTest, UpdateRequestProcessorFactoryTest, ChangedSchemaMergeTest, HighlighterConfigTest, FileBasedSpellCheckerTest, StandardRequestHandlerTest, BinaryUpdateRequestHandlerTest, TermVectorComponentDistributedTest, CSVRequestHandlerTest, CollectionsAPIDistributedZkTest, ResourceLoaderTest, DisMaxRequestHandlerTest, ConvertedLegacyTest, FastVectorHighlighterTest, XsltUpdateRequestHandlerTest, SolrCloudExampleTest, TestRecovery, StatelessScriptUpdateProcessorFactoryTest, ShardRoutingCustomTest, TestRangeQuery, TestManagedSchema, MinimalSchemaTest, NotRequiredUniqueKeyTest, OpenExchangeRatesOrgProviderTest, ZkSolrClientTest, StressHdfsTest, JsonLoaderTest, DistribCursorPagingTest, TestSystemIdResolver, DistributedQueryComponentOptimizationTest, TestPseudoReturnFields, DistributedIntervalFacetingTest, TestJoin, TestSolrDeletionPolicy2, EnumFieldTest, TestFastWriter, TestReplicationHandlerBackup]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestReplicationHandlerBackup -Dtests.seed=2D36CC422510AB74 -Dtests.slow=true -Dtests.locale=de_CH -Dtests.timezone=Asia/Oral -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J1 | TestReplicationHandlerBackup (suite) <<<
[junit4] > Throwable #1: java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
[junit4] > at __randomizedtesting.SeedInfo.seed([2D36CC422510AB74]:0)
[junit4] Completed [446/505] on J1 in 7283.96s, 2 tests, 2 errors <<< FAILURES!
[...truncated 207 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:526: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:474: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:61: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\extra-targets.xml:39: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:230: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:512: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1418: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:973: There were test failures: 505 suites, 1989 tests, 1 suite-level error, 1 error, 67 ignored (34 assumptions)
Total time: 166 minutes 26 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any