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/08/14 11:43:39 UTC
[JENKINS] Lucene-Solr-trunk-Windows (64bit/jdk1.8.0_51) - Build #
5148 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/5148/
Java: 64bit/jdk1.8.0_51 -XX:-UseCompressedOops -XX:+UseParallelGC
2 tests failed.
FAILED: org.apache.solr.handler.TestReplicationHandlerBackup.doTestBackup
Error Message:
Test abandoned because suite timeout was reached.
Stack Trace:
java.lang.Exception: Test abandoned because suite timeout was reached.
at __randomizedtesting.SeedInfo.seed([AED8FD7FB575B43D]: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([AED8FD7FB575B43D]:0)
Build Log:
[...truncated 11374 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_AED8FD7FB575B43D-001\init-core-data-001
[junit4] 2> 1052514 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[AED8FD7FB575B43D]) [ ] o.a.s.SolrTestCaseJ4 ###Starting doTestBackup
[junit4] 2> 1052515 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[AED8FD7FB575B43D]) [ ] 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_AED8FD7FB575B43D-001\solr-instance-001\collection1
[junit4] 2> 1052529 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[AED8FD7FB575B43D]) [ ] o.e.j.s.Server jetty-9.2.11.v20150529
[junit4] 2> 1052543 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[AED8FD7FB575B43D]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@87c3fd7{/solr,null,AVAILABLE}
[junit4] 2> 1052545 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[AED8FD7FB575B43D]) [ ] o.e.j.s.ServerConnector Started ServerConnector@42331356{HTTP/1.1}{127.0.0.1:51032}
[junit4] 2> 1052545 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[AED8FD7FB575B43D]) [ ] o.e.j.s.Server Started @1053270ms
[junit4] 2> 1052545 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[AED8FD7FB575B43D]) [ ] 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_AED8FD7FB575B43D-001\solr-instance-001\collection1\data, hostContext=/solr, hostPort=51032}
[junit4] 2> 1052545 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[AED8FD7FB575B43D]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a
[junit4] 2> 1052546 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[AED8FD7FB575B43D]) [ ] 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_AED8FD7FB575B43D-001\solr-instance-001\'
[junit4] 2> 1052564 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[AED8FD7FB575B43D]) [ ] 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_AED8FD7FB575B43D-001\solr-instance-001\solr.xml
[junit4] 2> 1052571 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[AED8FD7FB575B43D]) [ ] 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_AED8FD7FB575B43D-001\solr-instance-001\.
[junit4] 2> 1052571 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[AED8FD7FB575B43D]) [ ] o.a.s.c.CoreContainer New CoreContainer 336002761
[junit4] 2> 1052571 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[AED8FD7FB575B43D]) [ ] 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_AED8FD7FB575B43D-001\solr-instance-001\]
[junit4] 2> 1052571 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[AED8FD7FB575B43D]) [ ] 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_AED8FD7FB575B43D-001\solr-instance-001\lib
[junit4] 2> 1052571 WARN (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[AED8FD7FB575B43D]) [ ] 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_AED8FD7FB575B43D-001\solr-instance-001\lib).
[junit4] 2> 1052578 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[AED8FD7FB575B43D]) [ ] 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> 1052578 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[AED8FD7FB575B43D]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1052579 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[AED8FD7FB575B43D]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1052579 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[AED8FD7FB575B43D]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1052579 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[AED8FD7FB575B43D]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 1052579 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[AED8FD7FB575B43D]) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 1052580 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[AED8FD7FB575B43D]) [ ] 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_AED8FD7FB575B43D-001\solr-instance-001\.
[junit4] 2> 1052582 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[AED8FD7FB575B43D]) [ ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_AED8FD7FB575B43D-001\solr-instance-001\.\collection1, absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_AED8FD7FB575B43D-001\solr-instance-001\.\collection1\, dataDir=data\}
[junit4] 2> 1052582 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[AED8FD7FB575B43D]) [ ] 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_AED8FD7FB575B43D-001\solr-instance-001\.\collection1\
[junit4] 2> 1052583 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[AED8FD7FB575B43D]) [ ] o.a.s.c.CoresLocator Found 1 core definitions
[junit4] 2> 1052583 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[AED8FD7FB575B43D]) [ ] o.a.s.s.SolrDispatchFilter user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1
[junit4] 2> 1052583 INFO (TEST-TestReplicationHandlerBackup.doTestBackup-seed#[AED8FD7FB575B43D]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 1052584 INFO (coreLoadExecutor-3915-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_AED8FD7FB575B43D-001\solr-instance-001\.\collection1\'
[junit4] 2> 1052609 INFO (coreLoadExecutor-3915-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 1052611 INFO (coreLoadExecutor-3915-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 1052615 INFO (coreLoadExecutor-3915-thread-1) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1052615 INFO (coreLoadExecutor-3915-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_AED8FD7FB575B43D-001\solr-instance-001\.\collection1\conf\schema.xml
[junit4] 2> 1052618 INFO (coreLoadExecutor-3915-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1052621 INFO (coreLoadExecutor-3915-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 1052624 INFO (coreLoadExecutor-3915-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_AED8FD7FB575B43D-001\solr-instance-001\.\collection1\conf'
[junit4] 2> 1052624 INFO (coreLoadExecutor-3915-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_AED8FD7FB575B43D-001\solr-instance-001\.\collection1\
[junit4] 2> 1052624 INFO (coreLoadExecutor-3915-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1052624 INFO (coreLoadExecutor-3915-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_AED8FD7FB575B43D-001\solr-instance-001\.\collection1\], dataDir=[null]
[junit4] 2> 1052624 INFO (coreLoadExecutor-3915-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
[junit4] 2> 1052625 INFO (coreLoadExecutor-3915-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_AED8FD7FB575B43D-001\solr-instance-001\.\collection1\data\
[junit4] 2> 1052625 INFO (coreLoadExecutor-3915-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_AED8FD7FB575B43D-001\solr-instance-001\.\collection1\data\index/
[junit4] 2> 1052625 WARN (coreLoadExecutor-3915-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_AED8FD7FB575B43D-001\solr-instance-001\.\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 1052625 INFO (coreLoadExecutor-3915-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_AED8FD7FB575B43D-001\solr-instance-001\.\collection1\data\index
[junit4] 2> 1052625 INFO (coreLoadExecutor-3915-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=32, maxMergeAtOnceExplicit=24, maxMergedSegmentMB=61.5966796875, floorSegmentMB=0.583984375, forceMergeDeletesPctAllowed=1.5178850174807368, segmentsPerTier=14.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4684116452977374
[junit4] 2> 1052626 INFO (coreLoadExecutor-3915-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@48cd0bc1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3dbfb113),segFN=segments_1,generation=1}
[junit4] 2> 1052626 INFO (coreLoadExecutor-3915-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 1052627 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_AED8FD7FB575B43D-001\solr-instance-001\.\collection1\data\
[junit4] 2> 1052628 INFO (coreLoadExecutor-3915-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1052632 INFO (coreLoadExecutor-3915-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1052633 INFO (coreLoadExecutor-3915-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1052634 INFO (coreLoadExecutor-3915-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1052635 INFO (coreLoadExecutor-3915-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1052637 INFO (coreLoadExecutor-3915-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> 1052637 INFO (coreLoadExecutor-3915-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1052638 INFO (coreLoadExecutor-3915-thread-1) [ x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
[junit4] 2> 1052638 INFO (coreLoadExecutor-3915-thread-1) [ x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
[junit4] 2> 1052639 INFO (coreLoadExecutor-3915-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=46, maxMergeAtOnceExplicit=24, maxMergedSegmentMB=73.02734375, floorSegmentMB=1.388671875, forceMergeDeletesPctAllowed=3.116630743101215, segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 1052640 INFO (coreLoadExecutor-3915-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@48cd0bc1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3dbfb113),segFN=segments_1,generation=1}
[junit4] 2> 1052643 INFO (coreLoadExecutor-3915-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 1052643 INFO (coreLoadExecutor-3915-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@176832dc[collection1] main
[junit4] 2> 1052643 INFO (coreLoadExecutor-3915-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_AED8FD7FB575B43D-001\solr-instance-001\.\collection1\conf
[junit4] 2> 1052643 INFO (coreLoadExecutor-3915-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_AED8FD7FB575B43D-001\solr-instance-001\.\collection1\conf}
[junit4] 2> 1052643 INFO (coreLoadExecutor-3915-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_AED8FD7FB575B43D-001\solr-instance-001\.\collection1\conf
[junit4] 2> 1052644 INFO (coreLoadExecutor-3915-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 1052644 INFO (coreLoadExecutor-3915-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema-replication2.xml:schema.xml
[junit4] 2> 1052644 INFO (coreLoadExecutor-3915-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1052644 INFO (searcherExecutor-3916-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@176832dc[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1052644 INFO (coreLoadExecutor-3915-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 1053085 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.SolrCore [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1053085 INFO (qtp902335387-7932) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 0
[junit4] 2> 1053088 INFO (qtp902335387-7933) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0]} 0 1
[junit4] 2> 1053090 INFO (qtp902335387-7935) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1]} 0 0
[junit4] 2> 1053109 INFO (qtp902335387-7928) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2]} 0 0
[junit4] 2> 1053122 INFO (qtp902335387-7931) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[3]} 0 0
[junit4] 2> 1053145 INFO (qtp902335387-7934) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[4]} 0 0
[junit4] 2> 1053149 INFO (qtp902335387-7932) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[5]} 0 0
[junit4] 2> 1053170 INFO (qtp902335387-7933) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[6]} 0 0
[junit4] 2> 1053173 INFO (qtp902335387-7935) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[7]} 0 0
[junit4] 2> 1053177 INFO (qtp902335387-7928) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[8]} 0 0
[junit4] 2> 1053193 INFO (qtp902335387-7931) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[9]} 0 0
[junit4] 2> 1053197 INFO (qtp902335387-7934) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[10]} 0 0
[junit4] 2> 1053202 INFO (qtp902335387-7932) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[11]} 0 0
[junit4] 2> 1053218 INFO (qtp902335387-7933) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[12]} 0 0
[junit4] 2> 1053220 INFO (qtp902335387-7935) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[13]} 0 0
[junit4] 2> 1053223 INFO (qtp902335387-7928) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[14]} 0 0
[junit4] 2> 1053244 INFO (qtp902335387-7931) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[15]} 0 0
[junit4] 2> 1053246 INFO (qtp902335387-7934) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[16]} 0 0
[junit4] 2> 1053256 INFO (qtp902335387-7932) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[17]} 0 0
[junit4] 2> 1053284 INFO (qtp902335387-7933) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[18]} 0 0
[junit4] 2> 1053290 INFO (qtp902335387-7935) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[19]} 0 0
[junit4] 2> 1053319 INFO (qtp902335387-7928) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[20]} 0 0
[junit4] 2> 1053325 INFO (qtp902335387-7931) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[21]} 0 0
[junit4] 2> 1053334 INFO (qtp902335387-7934) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[22]} 0 0
[junit4] 2> 1053363 INFO (qtp902335387-7932) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[23]} 0 0
[junit4] 2> 1053378 INFO (qtp902335387-7933) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[24]} 0 0
[junit4] 2> 1053411 INFO (qtp902335387-7935) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[25]} 0 0
[junit4] 2> 1053414 INFO (qtp902335387-7928) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[26]} 0 0
[junit4] 2> 1053440 INFO (qtp902335387-7931) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[27]} 0 0
[junit4] 2> 1053457 INFO (qtp902335387-7934) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[28]} 0 0
[junit4] 2> 1053462 INFO (qtp902335387-7932) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[29]} 0 0
[junit4] 2> 1053469 INFO (qtp902335387-7933) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[30]} 0 0
[junit4] 2> 1053484 INFO (qtp902335387-7935) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[31]} 0 0
[junit4] 2> 1053488 INFO (qtp902335387-7928) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[32]} 0 0
[junit4] 2> 1053491 INFO (qtp902335387-7931) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[33]} 0 0
[junit4] 2> 1053501 INFO (qtp902335387-7934) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[34]} 0 0
[junit4] 2> 1053514 INFO (qtp902335387-7932) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[35]} 0 0
[junit4] 2> 1053516 INFO (qtp902335387-7933) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[36]} 0 0
[junit4] 2> 1053519 INFO (qtp902335387-7935) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[37]} 0 0
[junit4] 2> 1053521 INFO (qtp902335387-7928) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[38]} 0 0
[junit4] 2> 1053551 INFO (qtp902335387-7931) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[39]} 0 0
[junit4] 2> 1053556 INFO (qtp902335387-7934) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[40]} 0 0
[junit4] 2> 1053561 INFO (qtp902335387-7932) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[41]} 0 2
[junit4] 2> 1053566 INFO (qtp902335387-7933) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[42]} 0 0
[junit4] 2> 1053569 INFO (qtp902335387-7935) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[43]} 0 0
[junit4] 2> 1053571 INFO (qtp902335387-7928) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[44]} 0 0
[junit4] 2> 1053573 INFO (qtp902335387-7931) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[45]} 0 0
[junit4] 2> 1053575 INFO (qtp902335387-7934) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[46]} 0 0
[junit4] 2> 1053577 INFO (qtp902335387-7932) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[47]} 0 0
[junit4] 2> 1053581 INFO (qtp902335387-7933) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[48]} 0 0
[junit4] 2> 1053583 INFO (qtp902335387-7935) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[49]} 0 0
[junit4] 2> 1053586 INFO (qtp902335387-7928) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[50]} 0 0
[junit4] 2> 1053591 INFO (qtp902335387-7931) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[51]} 0 0
[junit4] 2> 1053593 INFO (qtp902335387-7934) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[52]} 0 0
[junit4] 2> 1053596 INFO (qtp902335387-7932) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[53]} 0 0
[junit4] 2> 1053599 INFO (qtp902335387-7933) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[54]} 0 0
[junit4] 2> 1053601 INFO (qtp902335387-7935) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[55]} 0 0
[junit4] 2> 1053603 INFO (qtp902335387-7928) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[56]} 0 0
[junit4] 2> 1053604 INFO (qtp902335387-7931) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[57]} 0 0
[junit4] 2> 1053606 INFO (qtp902335387-7934) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[58]} 0 0
[junit4] 2> 1053608 INFO (qtp902335387-7932) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[59]} 0 0
[junit4] 2> 1053610 INFO (qtp902335387-7933) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[60]} 0 0
[junit4] 2> 1053612 INFO (qtp902335387-7935) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[61]} 0 0
[junit4] 2> 1053644 INFO (qtp902335387-7928) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[62]} 0 0
[junit4] 2> 1053652 INFO (qtp902335387-7931) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[63]} 0 0
[junit4] 2> 1053673 INFO (qtp902335387-7934) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[64]} 0 0
[junit4] 2> 1053696 INFO (qtp902335387-7932) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[65]} 0 0
[junit4] 2> 1053699 INFO (qtp902335387-7933) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[66]} 0 0
[junit4] 2> 1053701 INFO (qtp902335387-7935) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[67]} 0 0
[junit4] 2> 1053703 INFO (qtp902335387-7928) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[68]} 0 0
[junit4] 2> 1053705 INFO (qtp902335387-7931) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[69]} 0 0
[junit4] 2> 1053707 INFO (qtp902335387-7934) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[70]} 0 0
[junit4] 2> 1053709 INFO (qtp902335387-7932) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[71]} 0 0
[junit4] 2> 1053711 INFO (qtp902335387-7933) [ x:collection1] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1053714 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@48cd0bc1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3dbfb113),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@48cd0bc1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3dbfb113),segFN=segments_2,generation=2}
[junit4] 2> 1053715 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 2
[junit4] 2> 1053716 INFO (Thread-3107) [ 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_AED8FD7FB575B43D-001\solr-instance-001\.\collection1\data\
[junit4] 2> 1053716 INFO (qtp902335387-7933) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@5dd61d21[collection1] main
[junit4] 2> 1053716 INFO (qtp902335387-7933) [ x:collection1] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 1053716 INFO (searcherExecutor-3916-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5dd61d21[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c72)))}
[junit4] 2> 1053716 INFO (qtp902335387-7933) [ x:collection1] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 6
[junit4] 2> 1053719 INFO (Thread-3107) [ 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_AED8FD7FB575B43D-001\solr-instance-001\.\collection1\data\
[junit4] 2> 1053720 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={name=lgeuatmbouhoqp&command=backup} status=0 QTime=1
[junit4] 2> 1053721 INFO (Thread-3108) [ x:collection1] o.a.s.h.SnapShooter Creating backup snapshot lgeuatmbouhoqp at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_AED8FD7FB575B43D-001\solr-instance-001\.\collection1\data\
[junit4] 2> 1053723 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1053724 INFO (Thread-3108) [ x:collection1] o.a.s.h.SnapShooter Done creating backup snapshot: lgeuatmbouhoqp at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_AED8FD7FB575B43D-001\solr-instance-001\.\collection1\data\
[junit4] 2> 1054722 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={name=qdvojywnnzjsnacxhl&command=backup} status=0 QTime=6
[junit4] 2> 1054736 INFO (Thread-3109) [ x:collection1] o.a.s.h.SnapShooter Creating backup snapshot qdvojywnnzjsnacxhl at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_AED8FD7FB575B43D-001\solr-instance-001\.\collection1\data\
[junit4] 2> 1054737 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1054740 INFO (Thread-3109) [ x:collection1] o.a.s.h.SnapShooter Done creating backup snapshot: qdvojywnnzjsnacxhl at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_AED8FD7FB575B43D-001\solr-instance-001\.\collection1\data\
[junit4] 2> 1055727 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={name=kpwuzjgnjaqbwu&command=backup} status=0 QTime=1
[junit4] 2> 1055727 INFO (Thread-3110) [ x:collection1] o.a.s.h.SnapShooter Creating backup snapshot kpwuzjgnjaqbwu at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_AED8FD7FB575B43D-001\solr-instance-001\.\collection1\data\
[junit4] 2> 1055732 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 1055733 INFO (Thread-3110) [ x:collection1] o.a.s.h.SnapShooter Done creating backup snapshot: kpwuzjgnjaqbwu at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_AED8FD7FB575B43D-001\solr-instance-001\.\collection1\data\
[junit4] 2> 1056713 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={name=ealccknjkqkqbxlean&command=backup} status=0 QTime=1
[junit4] 2> 1056740 INFO (Thread-3111) [ x:collection1] o.a.s.h.SnapShooter Creating backup snapshot ealccknjkqkqbxlean at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_AED8FD7FB575B43D-001\solr-instance-001\.\collection1\data\
[junit4] 2> 1056741 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1056743 INFO (Thread-3111) [ x:collection1] o.a.s.h.SnapShooter Done creating backup snapshot: ealccknjkqkqbxlean at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J1\temp\solr.handler.TestReplicationHandlerBackup_AED8FD7FB575B43D-001\solr-instance-001\.\collection1\data\
[junit4] 2> 1057646 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={name=lgeuatmbouhoqp&command=deletebackup} status=0 QTime=12
[junit4] 2> 1057647 INFO (Thread-3112) [ x:collection1] o.a.s.h.SnapShooter Deleting snapshot: lgeuatmbouhoqp
[junit4] 2> 1057655 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1058541 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={name=qdvojywnnzjsnacxhl&command=deletebackup} status=0 QTime=0
[junit4] 2> 1058542 INFO (Thread-3113) [ x:collection1] o.a.s.h.SnapShooter Deleting snapshot: qdvojywnnzjsnacxhl
[junit4] 2> 1058543 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1058721 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1058907 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1059090 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1059289 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1059467 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1059651 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1059831 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1060016 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1060208 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1060405 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1060586 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1060779 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1060964 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1061143 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1061325 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1061507 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1061695 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1061877 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1062055 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1062233 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1062411 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1062600 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1062778 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1062966 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1063149 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1063330 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 1063506 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1063693 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1063880 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1064063 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1064267 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1064466 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1064646 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1064826 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1065011 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 1065190 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1065368 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1065559 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1065722 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1065891 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1066050 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1066229 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1066402 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1066562 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1066740 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1066905 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1067081 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1067245 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1067412 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1067582 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1067741 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1067910 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1068072 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1068242 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1068430 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1068594 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1068755 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1068918 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1069079 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1069249 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1069408 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1069573 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1069742 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1069901 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1070061 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1070232 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1070397 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1070557 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1070719 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1070880 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1071049 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1071217 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1071382 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1071563 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1071727 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1071888 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1072063 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1072226 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1072390 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1072564 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1072729 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 1072888 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1073065 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1073226 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1073391 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1073589 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1073778 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1073954 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1074130 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1074322 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1074499 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1074681 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1074859 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1075033 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1075216 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1075395 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 1075581 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1075784 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1075961 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 1076145 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1076334 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1076514 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1076689 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1076875 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1077053 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1077228 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1077420 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1077597 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1077772 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1077959 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1078136 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1078324 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1078502 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1078682 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1078859 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1079046 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1079239 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1079423 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1079601 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1079777 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1079969 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1080163 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=10
[junit4] 2> 1080342 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1080532 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=17
[junit4] 2> 1080719 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1080907 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1081084 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1081269 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1081449 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1081627 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1081803 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1081992 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1082172 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1082383 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1082589 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1082784 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1082997 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1083205 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1083399 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1083593 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1083796 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1084003 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1084206 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1084400 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1084596 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1084789 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1084989 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1085183 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1085392 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1085584 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1085784 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1085979 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1086173 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1086368 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1086562 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1086755 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1086948 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1087158 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1087352 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 1087547 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1087744 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1087950 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1088145 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1088362 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1088559 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1088755 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1088948 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1089153 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=4
[junit4] 2> 1089355 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1089552 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1089748 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1089942 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1090148 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1090351 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1090566 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1090760 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1090968 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1091180 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1091408 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1091601 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1091813 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1092029 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1092249 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1092463 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1092697 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=19
[junit4] 2> 1092916 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1093134 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1093347 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1093579 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1093791 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1094005 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1094240 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1094454 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1094668 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1094897 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1095144 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=10
[junit4] 2> 1095363 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1095588 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1095804 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1096016 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1096248 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1096466 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1096699 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=10
[junit4] 2> 1096913 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1097130 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1097343 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1097573 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1097788 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1098000 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1098218 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1098445 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1098660 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1098874 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1099104 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1099319 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1099532 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1099759 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1099984 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1100195 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1100419 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1100634 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1100854 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1101066 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1101282 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=1
[junit4] 2> 1101494 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1101708 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1101944 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1102157 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1102374 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1102625 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1102859 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1103094 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1103343 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1103578 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1103831 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1104065 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1104301 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1104535 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1104769 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1105003 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1105250 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1105485 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1105746 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1105983 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1106219 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1106456 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1106692 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1106931 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1107180 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1107414 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1107649 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1107910 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1108146 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1108381 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1108619 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1108868 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1109151 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1109387 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1109638 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1109910 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1110163 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1110396 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1110653 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1110892 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1111131 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1111369 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1111604 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1111865 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1112100 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1112335 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1112574 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1112842 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1113077 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1113330 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1113574 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1113809 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1114053 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1114343 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1114603 INFO (qtp902335387-7934) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1114860 INFO (qtp902335387-7932) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1115119 INFO (qtp902335387-7933) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1115375 INFO (qtp902335387-7935) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1115649 INFO (qtp902335387-7928) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[junit4] 2> 1115949 INFO (qtp902335387-7931) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=details} status=0 QTime=0
[...truncated too long message...]
555 INFO (Thread-3134) [ 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_AED8FD7FB575B43D-001\solr-instance-002\.\collection1\data\
[junit4] 2> 8289557 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[AED8FD7FB575B43D]) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@30a92f80{HTTP/1.1}{127.0.0.1:0}
[junit4] 2> 8289557 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[AED8FD7FB575B43D]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=2022475509
[junit4] 2> 8289558 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[AED8FD7FB575B43D]) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@3ba5de9a
[junit4] 2> 8289558 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[AED8FD7FB575B43D]) [ 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=6,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
[junit4] 2> 8289558 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[AED8FD7FB575B43D]) [ x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 8289558 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[AED8FD7FB575B43D]) [ x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 8289558 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[AED8FD7FB575B43D]) [ x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
[junit4] 2> 8289558 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[AED8FD7FB575B43D]) [ x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
[junit4] 2> 8289558 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[AED8FD7FB575B43D]) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 8289558 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[AED8FD7FB575B43D]) [ 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_AED8FD7FB575B43D-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_AED8FD7FB575B43D-001\solr-instance-002\.\collection1\data\;done=false>>]
[junit4] 2> 8289558 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[AED8FD7FB575B43D]) [ 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_AED8FD7FB575B43D-001\solr-instance-002\.\collection1\data\
[junit4] 2> 8289558 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[AED8FD7FB575B43D]) [ 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_AED8FD7FB575B43D-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_AED8FD7FB575B43D-001\solr-instance-002\.\collection1\data\index;done=false>>]
[junit4] 2> 8289559 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[AED8FD7FB575B43D]) [ 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_AED8FD7FB575B43D-001\solr-instance-002\.\collection1\data\index
[junit4] 2> 8289559 INFO (TEST-TestReplicationHandlerBackup.testBackupOnCommit-seed#[AED8FD7FB575B43D]) [ x:collection1] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@33722fb2{/solr,null,UNAVAILABLE}
[junit4] 2> 8289560 INFO (SUITE-TestReplicationHandlerBackup-seed#[AED8FD7FB575B43D]-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_AED8FD7FB575B43D-001
[junit4] 2> Aug 14, 2015 9:39:00 AM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: All leaked threads terminated.
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene53): {name=PostingsFormat(name=Memory doPackFST= true), id=PostingsFormat(name=Memory doPackFST= true)}, docValues:{}, sim=DefaultSimilarity, locale=sk, timezone=Europe/Bucharest
[junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0_51 (64-bit)/cpus=3,threads=1,free=153950752,total=397934592
[junit4] 2> NOTE: All tests run in this JVM: [DocumentBuilderTest, SchemaVersionSpecificBehaviorTest, DeleteLastCustomShardedReplicaTest, TestUniqueKeyFieldResource, CollectionsAPIDistributedZkTest, CollectionStateFormat2Test, RAMDirectoryFactoryTest, TestFuzzyAnalyzedSuggestions, TestDynamicFieldCollectionResource, DistributedFacetPivotSmallAdvancedTest, TestCopyFieldCollectionResource, TestObjectReleaseTracker, TestMergePolicyConfig, DistributedQueryComponentCustomSortTest, TestAddFieldRealTimeGet, PluginInfoTest, TestRangeQuery, TestManagedSchemaFieldResource, HdfsUnloadDistributedZkTest, ExternalFileFieldSortTest, TestNoOpRegenerator, JsonLoaderTest, TestDynamicLoading, TestScoreJoinQPNoScore, TestFileDictionaryLookup, IndexBasedSpellCheckerTest, TestSolrCloudWithKerberosAlt, TestMacros, SolrCmdDistributorTest, StandardRequestHandlerTest, TestCollapseQParserPlugin, AliasIntegrationTest, BasicDistributedZk2Test, CdcrVersionReplicationTest, TestSearchPerf, TestScoreJoinQPScore, AsyncMigrateRouteKeyTest, TestDocBasedVersionConstraints, SSLMigrationTest, OverseerCollectionProcessorTest, TestSuggestSpellingConverter, TestFastWriter, TestRestManager, TestRealTimeGet, TestReqParamsAPI, TestCodecSupport, BufferStoreTest, TestLMJelinekMercerSimilarityFactory, CoreAdminCreateDiscoverTest, BasicZkTest, OpenCloseCoreStressTest, UUIDUpdateProcessorFallbackTest, TermVectorComponentDistributedTest, LeaderFailoverAfterPartitionTest, DistribCursorPagingTest, TestAnalyzeInfixSuggestions, ReplicationFactorTest, MinimalSchemaTest, BJQParserTest, LeaderInitiatedRecoveryOnCommitTest, DebugComponentTest, TestCrossCoreJoin, FileBasedSpellCheckerTest, DocExpirationUpdateProcessorFactoryTest, FullHLLTest, DistributedQueueTest, BitVectorTest, SearchHandlerTest, TestStressUserVersions, DirectSolrSpellCheckerTest, TestConfigReload, TestRecoveryHdfs, UpdateParamsTest, TestManagedSchemaDynamicFieldResource, TestSimpleTrackingShardHandler, HdfsLockFactoryTest, QueryEqualityTest, TestLuceneMatchVersion, TestQuerySenderListener, SolrIndexConfigTest, TestFiltering, AsyncCallRequestStatusResponseTest, TestSolrConfigHandler, BaseCdcrDistributedZkTest, TestDistribIDF, FieldMutatingUpdateProcessorTest, PolyFieldTest, TestSolrDeletionPolicy2, MoreLikeThisHandlerTest, HdfsWriteToMultipleCollectionsTest, RegexBoostProcessorTest, TestSolrQueryParserResource, HdfsRecoverLeaseTest, TestSolr4Spatial, VersionInfoTest, TestFoldingMultitermQuery, TestRestoreCore, TestSolrConfigHandlerCloud, CdcrUpdateLogTest, BasicFunctionalityTest, BadIndexSchemaTest, TestHdfsUpdateLog, TestRawResponseWriter, TestValueSourceCache, TestReplicationHandlerBackup]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestReplicationHandlerBackup -Dtests.seed=AED8FD7FB575B43D -Dtests.slow=true -Dtests.locale=sk -Dtests.timezone=Europe/Bucharest -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] ERROR 0.00s J1 | TestReplicationHandlerBackup (suite) <<<
[junit4] > Throwable #1: java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
[junit4] > at __randomizedtesting.SeedInfo.seed([AED8FD7FB575B43D]:0)
[junit4] Completed [514/540] on J1 in 7237.10s, 1 test, 2 errors <<< FAILURES!
[...truncated 94 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:775: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:719: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:59: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:233: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:514: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1429: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:984: There were test failures: 540 suites, 2130 tests, 1 suite-level error, 1 error, 76 ignored (41 assumptions)
Total time: 160 minutes 1 second
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
[JENKINS] Lucene-Solr-trunk-Windows (64bit/jdk1.8.0_51) - Build #
5149 - Still Failing!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/5149/
Java: 64bit/jdk1.8.0_51 -XX:-UseCompressedOops -XX:+UseParallelGC
2 tests failed.
FAILED: org.apache.solr.cloud.CollectionStateFormat2Test.test
Error Message:
Error from server at http://127.0.0.1:54878/jjcq/lx: Could not find collection : myExternColl
Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:54878/jjcq/lx: Could not find collection : myExternColl
at __randomizedtesting.SeedInfo.seed([D394B3E0088C4880:5BC08C3AA6702578]:0)
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:560)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:234)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:226)
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372)
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1086)
at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:857)
at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:800)
at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220)
at org.apache.solr.cloud.CollectionStateFormat2Test.testZkNodeLocation(CollectionStateFormat2Test.java:84)
at org.apache.solr.cloud.CollectionStateFormat2Test.test(CollectionStateFormat2Test.java:40)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:497)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:963)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:938)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
FAILED: org.apache.solr.handler.component.SpellCheckComponentTest.testThresholdTokenFrequency
Error Message:
Path not found: /spellcheck/suggestions/[1]/suggestion
Stack Trace:
java.lang.RuntimeException: Path not found: /spellcheck/suggestions/[1]/suggestion
at __randomizedtesting.SeedInfo.seed([D394B3E0088C4880:59333C11876771FB]:0)
at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:853)
at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:800)
at org.apache.solr.handler.component.SpellCheckComponentTest.testThresholdTokenFrequency(SpellCheckComponentTest.java:219)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:497)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 10483 lines...]
[junit4] Suite: org.apache.solr.handler.component.SpellCheckComponentTest
[junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.SpellCheckComponentTest_D394B3E0088C4880-001\init-core-data-001
[junit4] 2> 1650308 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false)
[junit4] 2> 1650309 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 1650310 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\'
[junit4] 2> 1650310 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 1650311 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 1650350 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 1650354 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 1650360 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig-spellcheckcomponent.xml
[junit4] 2> 1650361 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.s.IndexSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\schema.xml
[junit4] 2> 1650365 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 1650451 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1650457 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.s.IndexSchema default search field in schema is text
[junit4] 2> 1650458 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 1650462 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1650465 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1650467 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1650467 WARN (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE
[junit4] 2> 1650467 WARN (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING
[junit4] 2> 1650467 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1650468 WARN (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE
[junit4] 2> 1650468 WARN (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING
[junit4] 2> 1650468 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1650468 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr
[junit4] 2> 1650468 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\'
[junit4] 2> 1650489 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.c.CoreContainer New CoreContainer 127139815
[junit4] 2> 1650489 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\]
[junit4] 2> 1650489 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.c.CoreContainer loading shared library: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\lib
[junit4] 2> 1650489 WARN (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] 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\core\src\test-files\solr\lib).
[junit4] 2> 1650497 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
[junit4] 2> 1650505 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true
[junit4] 2> 1650509 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1650510 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1650510 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 1650510 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 1650513 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig-spellcheckcomponent.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, instanceDir=collection1, collection=collection1, absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.SpellCheckComponentTest_D394B3E0088C4880-001\init-core-data-001, shard=shard1}
[junit4] 2> 1650513 INFO (coreLoadExecutor-4552-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\'
[junit4] 2> 1650514 INFO (coreLoadExecutor-4552-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 1650514 INFO (coreLoadExecutor-4552-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 1650529 INFO (coreLoadExecutor-4552-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 1650532 INFO (coreLoadExecutor-4552-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 1650538 INFO (coreLoadExecutor-4552-thread-1) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig-spellcheckcomponent.xml
[junit4] 2> 1650539 INFO (coreLoadExecutor-4552-thread-1) [ ] o.a.s.s.IndexSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\schema.xml
[junit4] 2> 1650543 INFO (coreLoadExecutor-4552-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1650623 INFO (coreLoadExecutor-4552-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1650627 INFO (coreLoadExecutor-4552-thread-1) [ ] o.a.s.s.IndexSchema default search field in schema is text
[junit4] 2> 1650628 INFO (coreLoadExecutor-4552-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 1650632 INFO (coreLoadExecutor-4552-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1650634 INFO (coreLoadExecutor-4552-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1650636 INFO (coreLoadExecutor-4552-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1650636 WARN (coreLoadExecutor-4552-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE
[junit4] 2> 1650636 WARN (coreLoadExecutor-4552-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING
[junit4] 2> 1650636 INFO (coreLoadExecutor-4552-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1650637 WARN (coreLoadExecutor-4552-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE
[junit4] 2> 1650637 WARN (coreLoadExecutor-4552-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING
[junit4] 2> 1650640 INFO (coreLoadExecutor-4552-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf'
[junit4] 2> 1650640 INFO (coreLoadExecutor-4552-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\
[junit4] 2> 1650640 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1650641 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\], dataDir=[null]
[junit4] 2> 1650641 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
[junit4] 2> 1650641 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.SpellCheckComponentTest_D394B3E0088C4880-001\init-core-data-001\
[junit4] 2> 1650641 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.SpellCheckComponentTest_D394B3E0088C4880-001\init-core-data-001\index/
[junit4] 2> 1650641 WARN (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.SpellCheckComponentTest_D394B3E0088C4880-001\init-core-data-001\index' doesn't exist. Creating new index...
[junit4] 2> 1650641 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.SpellCheckComponentTest_D394B3E0088C4880-001\init-core-data-001\index
[junit4] 2> 1650642 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=26, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.37228404336567766]
[junit4] 2> 1650642 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@272fead lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3170b096),segFN=segments_1,generation=1}
[junit4] 2> 1650642 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 1650644 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1650648 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.SpellCheckComponentTest_D394B3E0088C4880-001\init-core-data-001\
[junit4] 2> 1650649 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1650650 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1650651 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1650651 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1650653 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,spellCheckCompRH,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,spellCheckCompRH1,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,/update/json,/admin/threads,/admin/ping,/update,/admin/file
[junit4] 2> 1650654 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1650654 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
[junit4] 2> 1650654 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
[junit4] 2> 1650654 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=37, maxMergeAtOnceExplicit=40, maxMergedSegmentMB=87.1240234375, floorSegmentMB=1.8310546875, forceMergeDeletesPctAllowed=26.86627603781866, segmentsPerTier=45.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 1650655 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@272fead lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3170b096),segFN=segments_1,generation=1}
[junit4] 2> 1650655 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 1650655 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@597f9f6c[collection1] main
[junit4] 2> 1650655 WARN (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf; switching to use InMemory storage instead.
[junit4] 2> 1650656 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
[junit4] 2> 1650656 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 1650656 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 1650656 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1650679 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: default
[junit4] 2> 1650698 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: default_teststop
[junit4] 2> 1650740 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=solr.DirectSolrSpellChecker,minQueryLength=3,maxQueryFrequency=100.0,field=teststop}
[junit4] 2> 1650740 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct_lowerfilt,classname=solr.DirectSolrSpellChecker,minQueryLength=3,maxQueryFrequency=100.0,field=lowerfilt}
[junit4] 2> 1650757 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: threshold
[junit4] 2> 1650758 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=threshold_direct,classname=solr.DirectSolrSpellChecker,field=lowerfilt,spellcheckIndexDir=spellcheckerThreshold,buildOnCommit=true,thresholdTokenFrequency=0.29}
[junit4] 2> 1650758 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: threshold_direct
[junit4] 2> 1650777 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: multipleFields
[junit4] 2> 1650819 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: freq
[junit4] 2> 1650844 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: fqcn
[junit4] 2> 1650844 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1650844 INFO (coreLoadExecutor-4552-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 1650846 INFO (SUITE-SpellCheckComponentTest-seed#[D394B3E0088C4880]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 1650848 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testThresholdTokenFrequency
[junit4] 2> 1650848 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[0]} 0 0
[junit4] 2> 1650853 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[1]} 0 0
[junit4] 2> 1650854 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[2]} 0 0
[junit4] 2> 1650854 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[3]} 0 0
[junit4] 2> 1650855 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[4]} 0 0
[junit4] 2> 1650855 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[5]} 0 0
[junit4] 2> 1650856 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[6]} 0 0
[junit4] 2> 1650856 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[7]} 0 0
[junit4] 2> 1650856 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[8]} 0 0
[junit4] 2> 1650857 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[9]} 0 0
[junit4] 2> 1650857 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1650860 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@272fead lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3170b096),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@272fead lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3170b096),segFN=segments_2,generation=2}
[junit4] 2> 1650861 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore newest commit generation = 2
[junit4] 2> 1650861 WARN (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore [collection1] PERFORMANCE WARNING: Overlapping onDeckSearchers=2
[junit4] 2> 1650862 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@65d7f545[collection1] main
[junit4] 2> 1650862 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 1650868 INFO (searcherExecutor-4553-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1650869 INFO (searcherExecutor-4553-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default_teststop
[junit4] 2> 1650870 INFO (searcherExecutor-4553-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1650870 INFO (searcherExecutor-4553-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct_lowerfilt
[junit4] 2> 1650870 INFO (searcherExecutor-4553-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1650870 INFO (searcherExecutor-4553-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold
[junit4] 2> 1650871 INFO (searcherExecutor-4553-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold_direct
[junit4] 2> 1650871 INFO (searcherExecutor-4553-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 1650871 INFO (searcherExecutor-4553-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1650872 INFO (searcherExecutor-4553-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1650872 INFO (searcherExecutor-4553-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1650873 INFO (searcherExecutor-4553-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1650873 INFO (searcherExecutor-4553-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1650873 INFO (searcherExecutor-4553-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@597f9f6c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1650874 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1650874 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default_teststop
[junit4] 2> 1650875 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1650875 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct_lowerfilt
[junit4] 2> 1650875 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1650875 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold
[junit4] 2> 1650875 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold_direct
[junit4] 2> 1650876 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 1650876 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1650877 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1650877 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1650878 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1650878 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1650879 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@65d7f545[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c10)))}
[junit4] 2> 1650879 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 21
[junit4] 2> 1650881 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=documenq&qt=spellCheckCompRH&spellcheck.dictionary=threshold&spellcheck=true&spellcheck.count=5&wt=xml&spellcheck.extendedResults=true} hits=0 status=0 QTime=1
[junit4] 2> 1650881 ERROR (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.SolrTestCaseJ4 query failed JSON validation. error=Path not found: /spellcheck/suggestions/[1]/suggestion
[junit4] 2> expected =/spellcheck/suggestions/[1]/suggestion==[{'word':'document','freq':2}]
[junit4] 2> response = {
[junit4] 2> "responseHeader":{
[junit4] 2> "status":0,
[junit4] 2> "QTime":1},
[junit4] 2> "response":{"numFound":0,"start":0,"docs":[]
[junit4] 2> },
[junit4] 2> "spellcheck":{
[junit4] 2> "suggestions":[],
[junit4] 2> "correctlySpelled":false}}
[junit4] 2>
[junit4] 2> request = q=documenq&qt=spellCheckCompRH&spellcheck.dictionary=threshold&spellcheck=true&spellcheck.count=5&wt=xml&spellcheck.extendedResults=true
[junit4] 2> 1650881 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testThresholdTokenFrequency
[junit4] 2> 1650882 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1650882 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
[junit4] 2> 1650882 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1650882 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@272fead lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3170b096),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@272fead lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3170b096),segFN=segments_3,generation=3}
[junit4] 2> 1650883 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore newest commit generation = 3
[junit4] 2> 1650883 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@3758a3d9[collection1] main
[junit4] 2> 1650883 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 1650883 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1650923 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1650987 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1651020 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1651020 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1651036 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1651054 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1651067 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3758a3d9[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1651068 INFO (TEST-SpellCheckComponentTest.testThresholdTokenFrequency-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 177
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SpellCheckComponentTest -Dtests.method=testThresholdTokenFrequency -Dtests.seed=D394B3E0088C4880 -Dtests.slow=true -Dtests.locale=ar_LY -Dtests.timezone=Australia/Hobart -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] ERROR 0.23s J0 | SpellCheckComponentTest.testThresholdTokenFrequency <<<
[junit4] > Throwable #1: java.lang.RuntimeException: Path not found: /spellcheck/suggestions/[1]/suggestion
[junit4] > at __randomizedtesting.SeedInfo.seed([D394B3E0088C4880:59333C11876771FB]:0)
[junit4] > at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:853)
[junit4] > at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:800)
[junit4] > at org.apache.solr.handler.component.SpellCheckComponentTest.testThresholdTokenFrequency(SpellCheckComponentTest.java:219)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 1651074 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[D394B3E0088C4880]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testExtendedResultsCount
[junit4] 2> 1651075 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[0]} 0 0
[junit4] 2> 1651075 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[1]} 0 0
[junit4] 2> 1651075 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[2]} 0 0
[junit4] 2> 1651076 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[3]} 0 0
[junit4] 2> 1651076 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[4]} 0 0
[junit4] 2> 1651077 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[5]} 0 0
[junit4] 2> 1651077 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[6]} 0 0
[junit4] 2> 1651077 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[7]} 0 0
[junit4] 2> 1651078 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[8]} 0 0
[junit4] 2> 1651078 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[9]} 0 0
[junit4] 2> 1651078 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[D394B3E0088C4880]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1651081 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@272fead lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3170b096),segFN=segments_3,generation=3}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@272fead lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3170b096),segFN=segments_4,generation=4}
[junit4] 2> 1651081 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore newest commit generation = 4
[junit4] 2> 1651082 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[D394B3E0088C4880]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@452f067f[collection1] main
[junit4] 2> 1651082 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[D394B3E0088C4880]) [ ] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 1651082 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1651162 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1651182 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1651288 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1651288 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1651360 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1651437 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1651617 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@452f067f[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):c10)))}
[junit4] 2> 1651618 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 517
[junit4] 2> 1651769 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[D394B3E0088C4880]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=bluo&qt=spellCheckCompRH&spellcheck=true&spellcheck.count=5&wt=xml&spellcheck.build=true&spellcheck.extendedResults=false} hits=0 status=0 QTime=144
[junit4] 2> 1651770 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[D394B3E0088C4880]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=bluo&qt=spellCheckCompRH&spellcheck=true&spellcheck.count=3&wt=xml&spellcheck.extendedResults=true} hits=0 status=0 QTime=0
[junit4] 2> 1651770 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[D394B3E0088C4880]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testExtendedResultsCount
[junit4] 2> 1651770 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1651770 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
[junit4] 2> 1651771 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[D394B3E0088C4880]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1651771 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@272fead lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3170b096),segFN=segments_4,generation=4}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@272fead lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3170b096),segFN=segments_5,generation=5}
[junit4] 2> 1651771 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore newest commit generation = 5
[junit4] 2> 1651771 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[D394B3E0088C4880]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@72c6f280[collection1] main
[junit4] 2> 1651771 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[D394B3E0088C4880]) [ ] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 1651771 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1651813 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1651849 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1651905 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1651906 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1651952 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1652017 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1652073 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@72c6f280[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1652073 INFO (TEST-SpellCheckComponentTest.testExtendedResultsCount-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 292
[junit4] 2> 1652075 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D394B3E0088C4880]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testRelativeIndexDirLocation
[junit4] 2> 1652076 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[0]} 0 0
[junit4] 2> 1652076 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[1]} 0 0
[junit4] 2> 1652077 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[2]} 0 0
[junit4] 2> 1652077 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[3]} 0 0
[junit4] 2> 1652078 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[4]} 0 0
[junit4] 2> 1652078 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[5]} 0 0
[junit4] 2> 1652078 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[6]} 0 0
[junit4] 2> 1652079 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[7]} 0 0
[junit4] 2> 1652079 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[8]} 0 0
[junit4] 2> 1652079 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[9]} 0 0
[junit4] 2> 1652079 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D394B3E0088C4880]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1652082 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@272fead lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3170b096),segFN=segments_5,generation=5}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@272fead lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3170b096),segFN=segments_6,generation=6}
[junit4] 2> 1652082 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore newest commit generation = 6
[junit4] 2> 1652082 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D394B3E0088C4880]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@28877510[collection1] main
[junit4] 2> 1652083 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D394B3E0088C4880]) [ ] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 1652083 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1652345 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1652378 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1652529 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1652529 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1652602 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1652663 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1652725 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@28877510[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(6.0.0):c10)))}
[junit4] 2> 1652725 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 626
[junit4] 2> 1652728 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D394B3E0088C4880]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testRelativeIndexDirLocation
[junit4] 2> 1652728 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1652728 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
[junit4] 2> 1652728 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D394B3E0088C4880]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1652729 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@272fead lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3170b096),segFN=segments_6,generation=6}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@272fead lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3170b096),segFN=segments_7,generation=7}
[junit4] 2> 1652729 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore newest commit generation = 7
[junit4] 2> 1652729 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D394B3E0088C4880]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@7bb3a270[collection1] main
[junit4] 2> 1652730 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D394B3E0088C4880]) [ ] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 1652730 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1652743 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1652753 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1652764 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1652764 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1652778 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1652790 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1652802 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7bb3a270[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1652803 INFO (TEST-SpellCheckComponentTest.testRelativeIndexDirLocation-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 70
[junit4] 2> 1652804 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testCorrectSpelling
[junit4] 2> 1652804 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[0]} 0 0
[junit4] 2> 1652804 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[1]} 0 0
[junit4] 2> 1652804 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[2]} 0 0
[junit4] 2> 1652804 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[3]} 0 0
[junit4] 2> 1652804 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[4]} 0 0
[junit4] 2> 1652804 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[5]} 0 0
[junit4] 2> 1652804 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[6]} 0 0
[junit4] 2> 1652806 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[7]} 0 0
[junit4] 2> 1652806 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[8]} 0 0
[junit4] 2> 1652807 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[9]} 0 0
[junit4] 2> 1652808 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1652813 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@272fead lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3170b096),segFN=segments_7,generation=7}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@272fead lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3170b096),segFN=segments_8,generation=8}
[junit4] 2> 1652813 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore newest commit generation = 8
[junit4] 2> 1652814 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@4f7cf18e[collection1] main
[junit4] 2> 1652815 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 1652815 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1652884 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1652897 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1652984 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1652984 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1653144 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1653291 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1653402 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4f7cf18e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(6.0.0):c10)))}
[junit4] 2> 1653402 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 571
[junit4] 2> 1653404 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=lowerfilt:lazy+lowerfilt:brown&qt=spellCheckCompRH&json.nl=map&spellcheck=true&wt=xml&spellcheck.extendedResults=true} hits=1 status=0 QTime=1
[junit4] 2> 1653405 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=lowerfilt:lazy+lowerfilt:brown&qt=spellCheckCompRH&spellcheck.dictionary=direct_lowerfilt&json.nl=map&spellcheck=true&wt=xml&spellcheck.extendedResults=true} hits=1 status=0 QTime=0
[junit4] 2> 1653407 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=lakkle&qt=spellCheckCompRH&spellcheck.dictionary=direct_lowerfilt&json.nl=map&spellcheck=true&wt=xml&spellcheck.extendedResults=true} hits=0 status=0 QTime=1
[junit4] 2> 1653407 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testCorrectSpelling
[junit4] 2> 1653407 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1653407 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
[junit4] 2> 1653408 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1653408 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@272fead lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3170b096),segFN=segments_8,generation=8}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@272fead lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3170b096),segFN=segments_9,generation=9}
[junit4] 2> 1653408 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore newest commit generation = 9
[junit4] 2> 1653408 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@d032e00[collection1] main
[junit4] 2> 1653408 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 1653408 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1653461 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1653482 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1653534 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1653534 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1653675 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1653754 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1653794 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@d032e00[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1653794 INFO (TEST-SpellCheckComponentTest.testCorrectSpelling-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 375
[junit4] 2> 1653797 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testRebuildOnCommit
[junit4] 2> 1653797 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[0]} 0 0
[junit4] 2> 1653798 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[1]} 0 0
[junit4] 2> 1653798 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[2]} 0 0
[junit4] 2> 1653798 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[3]} 0 0
[junit4] 2> 1653799 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[4]} 0 0
[junit4] 2> 1653799 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[5]} 0 0
[junit4] 2> 1653799 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[6]} 0 0
[junit4] 2> 1653800 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[7]} 0 0
[junit4] 2> 1653801 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[8]} 0 0
[junit4] 2> 1653801 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[9]} 0 0
[junit4] 2> 1653801 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1653803 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@272fead lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3170b096),segFN=segments_9,generation=9}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@272fead lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3170b096),segFN=segments_a,generation=10}
[junit4] 2> 1653804 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore newest commit generation = 10
[junit4] 2> 1653804 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@45583a20[collection1] main
[junit4] 2> 1653805 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 1653805 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1653910 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1653942 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1654034 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1654034 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1654156 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1654253 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1654478 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@45583a20[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(6.0.0):c10)))}
[junit4] 2> 1654479 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 655
[junit4] 2> 1654480 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=lowerfilt:lucenejavt&qt=spellCheckCompRH&spellcheck=true&wt=xml} hits=0 status=0 QTime=1
[junit4] 2> 1654481 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[11231]} 0 0
[junit4] 2> 1654481 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1654483 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@272fead lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3170b096),segFN=segments_a,generation=10}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@272fead lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3170b096),segFN=segments_b,generation=11}
[junit4] 2> 1654483 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore newest commit generation = 11
[junit4] 2> 1654484 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@502d9c29[collection1] main
[junit4] 2> 1654484 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 1654484 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1654659 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1654679 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1654702 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1654702 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1654840 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1654951 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1655031 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@502d9c29[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(6.0.0):c10) Uninverting(_5(6.0.0):c1)))}
[junit4] 2> 1655031 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 508
[junit4] 2> 1655033 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=lowerfilt:lucenejavt&qt=spellCheckCompRH&spellcheck=true&wt=xml} hits=0 status=0 QTime=511
[junit4] 2> 1655033 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testRebuildOnCommit
[junit4] 2> 1655033 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1655034 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
[junit4] 2> 1655034 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1655034 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@272fead lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3170b096),segFN=segments_b,generation=11}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@272fead lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3170b096),segFN=segments_c,generation=12}
[junit4] 2> 1655034 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore newest commit generation = 12
[junit4] 2> 1655034 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@7c1fe9b6[collection1] main
[junit4] 2> 1655035 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 1655035 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1655062 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1655092 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1655107 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1655108 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1655151 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1655175 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1655216 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7c1fe9b6[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1655217 INFO (TEST-SpellCheckComponentTest.testRebuildOnCommit-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 159
[junit4] 2> 1655219 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D394B3E0088C4880]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testCollate
[junit4] 2> 1655219 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[0]} 0 0
[junit4] 2> 1655219 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[1]} 0 0
[junit4] 2> 1655221 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[2]} 0 0
[junit4] 2> 1655221 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[3]} 0 0
[junit4] 2> 1655221 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[4]} 0 0
[junit4] 2> 1655222 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[5]} 0 0
[junit4] 2> 1655222 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[6]} 0 0
[junit4] 2> 1655222 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[7]} 0 0
[junit4] 2> 1655222 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[8]} 0 0
[junit4] 2> 1655223 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[9]} 0 0
[junit4] 2> 1655223 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D394B3E0088C4880]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1655226 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@272fead lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3170b096),segFN=segments_c,generation=12}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@272fead lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3170b096),segFN=segments_d,generation=13}
[junit4] 2> 1655226 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D394B3E0088C4880]) [ ] o.a.s.c.SolrCore newest commit generation = 13
[junit4] 2> 1655227 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D394B3E0088C4880]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@52a3e37d[collection1] main
[junit4] 2> 1655227 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D394B3E0088C4880]) [ ] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 1655227 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default
[junit4] 2> 1655297 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop
[junit4] 2> 1655321 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold
[junit4] 2> 1655380 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct
[junit4] 2> 1655380 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields
[junit4] 2> 1655456 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq
[junit4] 2> 1655540 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn
[junit4] 2> 1655664 INFO (searcherExecutor-4553-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@52a3e37d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_6(6.0.0):c10)))}
[junit4] 2> 1655665 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D394B3E0088C4880]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 387
[junit4] 2> 1655900 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D394B3E0088C4880]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=documemt&qt=spellCheckCompRH&json.nl=map&spellcheck=true&wt=xml&spellcheck.build=true&spellcheck.collate=true} hits=0 status=0 QTime=206
[junit4] 2> 1655901 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D394B3E0088C4880]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=documemt+lowerfilt:broen^4&qt=spellCheckCompRH&json.nl=map&spellcheck=true&wt=xml&spellcheck.collate=true} hits=0 status=0 QTime=0
[junit4] 2> 1655902 INFO (TEST-SpellCheckComponentTest.testCollate-seed#[D394B3E0088C4880]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=documemtsss+broens&qt=spellCheckCompRH&json.nl=map&spellcheck=true&wt=xml&spellcheck.collate=true} hits=0 status=0 QTime=0
[junit4] 2> 1655904 INFO (TEST-SpellCheckComponentTest.tes
[...truncated too long message...]
#[D394B3E0088C4880]) [n:127.0.0.1:54892_jjcq%2Flx c:collection1 s:shard1 r:core_node4 x:collection1] o.a.s.c.ZkTestServer connecting to 127.0.0.1:54817 54817
[junit4] 2> 1905637 INFO (Thread-4377) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:54817 54817
[junit4] 2> 1905639 WARN (Thread-4377) [ ] o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 8 /solr/aliases.json
[junit4] 2> 5 /solr/security.json
[junit4] 2> 5 /solr/configs/conf1
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 8 /solr/clusterstate.json
[junit4] 2> 4 /solr/collections/collection1/state.json
[junit4] 2> 4 /solr/collections/myExternColl/state.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 8 /solr/live_nodes
[junit4] 2> 2 /solr/overseer/collection-queue-work
[junit4] 2>
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=CollectionStateFormat2Test -Dtests.method=test -Dtests.seed=D394B3E0088C4880 -Dtests.slow=true -Dtests.locale=vi_VN -Dtests.timezone=Asia/Beirut -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] ERROR 56.4s J0 | CollectionStateFormat2Test.test <<<
[junit4] > Throwable #1: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:54878/jjcq/lx: Could not find collection : myExternColl
[junit4] > at __randomizedtesting.SeedInfo.seed([D394B3E0088C4880:5BC08C3AA6702578]:0)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:560)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:234)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:226)
[junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372)
[junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
[junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1086)
[junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:857)
[junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:800)
[junit4] > at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220)
[junit4] > at org.apache.solr.cloud.CollectionStateFormat2Test.testZkNodeLocation(CollectionStateFormat2Test.java:84)
[junit4] > at org.apache.solr.cloud.CollectionStateFormat2Test.test(CollectionStateFormat2Test.java:40)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:963)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:938)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 1905644 INFO (SUITE-CollectionStateFormat2Test-seed#[D394B3E0088C4880]-worker) [n:127.0.0.1:54892_jjcq%2Flx c:collection1 s:shard1 r:core_node4 x:collection1] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.CollectionStateFormat2Test_D394B3E0088C4880-001
[junit4] 2> NOTE: test params are: codec=Lucene53, sim=RandomSimilarityProvider(queryNorm=true,coord=yes): {}, locale=vi_VN, timezone=Asia/Beirut
[junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0_51 (64-bit)/cpus=3,threads=1,free=57379672,total=528482304
[junit4] 2> NOTE: All tests run in this JVM: [SuggestComponentTest, SuggesterWFSTTest, DistributedVersionInfoTest, TestConfigOverlay, TestMaxScoreQueryParser, TestExceedMaxTermLength, TestXIncludeConfig, TestInitParams, CustomCollectionTest, TestRequestStatusCollectionAPI, ShardRoutingTest, TestCSVLoader, LukeRequestHandlerTest, TestCSVResponseWriter, TestCryptoKeys, HdfsRecoveryZkTest, TestIndexingPerformance, TestHashQParserPlugin, SolrCoreCheckLockOnStartupTest, TestCharFilters, TestJsonFacets, ClusterStateUpdateTest, SuggesterFSTTest, HighlighterMaxOffsetTest, PingRequestHandlerTest, SoftAutoCommitTest, TestCloudManagedSchemaConcurrent, SampleTest, CoreMergeIndexesAdminHandlerTest, TestDocumentBuilder, TestConfigSets, TestReplicaProperties, HdfsNNFailoverTest, TestSweetSpotSimilarityFactory, TestDistributedSearch, JavabinLoaderTest, QueryResultKeyTest, TestFastLRUCache, OutOfBoxZkACLAndCredentialsProvidersTest, DOMUtilTest, TestStressLucene, TestSurroundQueryParser, TestBlendedInfixSuggestions, ZkStateReaderTest, TestStressVersions, TestClusterStateMutator, TestBM25SimilarityFactory, TestShortCircuitedRequests, RequiredFieldsTest, TestLRUCache, CircularListTest, TestConfigSetProperties, TestHashPartitioner, TestSolrDynamicMBean, TestRemoveLastDynamicCopyField, UnloadDistributedZkTest, SolrPluginUtilsTest, TestSortingResponseWriter, TestRandomDVFaceting, TestPostingsSolrHighlighter, IndexSchemaRuntimeFieldTest, SolrIndexSplitterTest, RecoveryAfterSoftCommitTest, ChaosMonkeyNothingIsSafeTest, ConcurrentDeleteAndCreateCollectionTest, TestManagedSchema, TestInitQParser, TestMiniSolrCloudClusterSSL, ZkControllerTest, DeleteShardTest, CachingDirectoryFactoryTest, DistributedFacetPivotLongTailTest, TestLFUCache, TestManagedResourceStorage, SmileWriterTest, TestCursorMarkWithoutUniqueKey, TestIntervalFaceting, DistribDocExpirationUpdateProcessorTest, CoreAdminRequestStatusTest, TestConfigSetImmutable, CloudExitableDirectoryReaderTest, TestSchemaNameResource, SolrInfoMBeanTest, ExplicitHLLTest, PreAnalyzedFieldTest, TestSchemaVersionResource, TestSolr4Spatial2, TestQueryTypes, TestPhraseSuggestions, BadCopyFieldTest, TestSchemaSimilarityResource, TestManagedSynonymFilterFactory, OverseerRolesTest, RuleEngineTest, AssignTest, TestWordDelimiterFilterFactory, DistributedFacetPivotSmallTest, HdfsDirectoryFactoryTest, DistanceFunctionTest, TestFieldTypeCollectionResource, TestIBSimilarityFactory, CdcrReplicationHandlerTest, ScriptEngineTest, TestFieldSortValues, TestJmxMonitoredMap, AlternateDirectoryTest, TestNamedUpdateProcessors, ZkCLITest, TestUpdate, TestWriterPerf, SortByFunctionTest, TestQueryUtils, DistributedExpandComponentTest, TestArbitraryIndexDir, NoCacheHeaderTest, TestExtendedDismaxParser, HdfsBasicDistributedZkTest, TestGroupingSearch, TestBulkSchemaConcurrent, DistributedDebugComponentTest, HdfsCollectionsAPIDistributedZkTest, SuggesterTest, TestReloadDeadlock, SOLR749Test, VMParamsZkACLAndCredentialsProvidersTest, TestDefaultSearchFieldResource, TestCloudInspectUtil, DistributedSuggestComponentTest, TestFunctionQuery, AnalysisErrorHandlingTest, RecoveryZkTest, TestReplicationHandler, ZkSolrClientTest, TestRealTimeGet, HardAutoCommitTest, TestRangeQuery, SimpleFacetsTest, SpellCheckComponentTest, PeerSyncTest, BasicFunctionalityTest, DirectUpdateHandlerTest, TestBadConfig, TestIndexSearcher, ShowFileRequestHandlerTest, CurrencyFieldXmlFileTest, AnalysisAfterCoreReloadTest, SignatureUpdateProcessorFactoryTest, SpellCheckCollatorTest, SolrRequestParserTest, SuggesterTSTTest, SchemaVersionSpecificBehaviorTest, TestAtomicUpdateErrorCases, DefaultValueUpdateProcessorTest, TestRemoteStreaming, DocValuesMultiTest, XsltUpdateRequestHandlerTest, CacheHeaderTest, DisMaxRequestHandlerTest, TestReversedWildcardFilterFactory, DocumentAnalysisRequestHandlerTest, XmlUpdateRequestHandlerTest, DocumentBuilderTest, MoreLikeThisHandlerTest, FastVectorHighlighterTest, TestJmxIntegration, ReturnFieldsTest, JSONWriterTest, TestAnalyzedSuggestions, CSVRequestHandlerTest, SearchHandlerTest, TestQuerySenderNoQuery, SolrIndexConfigTest, MultiTermTest, TestDocSet, NumericFieldsTest, OutputWriterTest, NotRequiredUniqueKeyTest, SpellPossibilityIteratorTest, SynonymTokenizerTest, TestPerFieldSimilarity, TestFastWriter, TestFastOutputStream, DateMathParserTest, TestSystemIdResolver, PrimUtilsTest, TestSuggestSpellingConverter, SpellingQueryConverterTest, ClusterStateTest, SliceStateTest, SystemInfoHandlerTest, UUIDFieldTest, DistributedMLTComponentTest, SolrTestCaseJ4Test, TestDistributedMissingSort, AsyncMigrateRouteKeyTest, CdcrVersionReplicationTest, CollectionStateFormat2Test]
[junit4] Completed [412/540] on J0 in 56.39s, 1 test, 1 error <<< FAILURES!
[...truncated 412 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:775: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:719: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:59: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:233: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:514: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1429: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:984: There were test failures: 540 suites, 2131 tests, 2 errors, 76 ignored (41 assumptions)
Total time: 67 minutes 1 second
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any