Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/13786/
Java: 32bit/jdk1.8.0_60-ea-b24 -server -XX:+UseSerialGC
1 tests failed.
FAILED: org.apache.solr.search.TestStressReorder.testStressReorderVersions
Error Message:
Captured an uncaught exception in thread: Thread[id=7093, name=READER4,
state=RUNNABLE, group=TGRP-TestStressReorder]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught
exception in thread: Thread[id=7093, name=READER4, state=RUNNABLE,
group=TGRP-TestStressReorder]
at
__randomizedtesting.SeedInfo.seed([3E5BE83C5675AACC:229DD12A5CBE2E41]:0)
Caused by: java.lang.RuntimeException: java.lang.AssertionError
at __randomizedtesting.SeedInfo.seed([3E5BE83C5675AACC]:0)
at
org.apache.solr.search.TestStressReorder$2.run(TestStressReorder.java:316)
Caused by: java.lang.AssertionError
at org.junit.Assert.fail(Assert.java:92)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertTrue(Assert.java:54)
at
org.apache.solr.search.TestStressReorder$2.run(TestStressReorder.java:309)
Build Log:
[...truncated 10383 lines...]
[junit4] Suite: org.apache.solr.search.TestStressReorder
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestStressReorder_3E5BE83C5675AACC-001/init-core-data-001
[junit4] 2> 902944 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
[junit4] 2> 902945 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 902945 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 902945 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.c.SolrResourceLoader Adding
'file:/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/classes/'
to classloader
[junit4] 2> 902945 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.c.SolrResourceLoader Adding
'file:/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/README'
to classloader
[junit4] 2> 902961 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 902963 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 902970 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ] o.a.s.c.Config
Loaded SolrConfig: solrconfig-tlog.xml
[junit4] 2> 902970 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.s.IndexSchema Reading Solr Schema from
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/schema15.xml
[junit4] 2> 902974 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 903035 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.s.IndexSchema default search field in schema is text
[junit4] 2> 903035 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 903036 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 903038 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 903042 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 903042 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.c.SolrResourceLoader using system property solr.solr.home:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr
[junit4] 2> 903042 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/'
[junit4] 2> 903049 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.c.CoreContainer New CoreContainer 25439390
[junit4] 2> 903050 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/]
[junit4] 2> 903050 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.c.CoreContainer loading shared library:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/lib
[junit4] 2> 903050 WARN
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to
classloader: lib (resolved as:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/lib).
[junit4] 2> 903054 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-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> 903057 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=30000&connTimeout=30000&retry=true
[junit4] 2> 903057 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 903057 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 903058 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for
authorization module.
[junit4] 2> 903058 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 903058 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1,
config=solrconfig-tlog.xml, transient=false, schema=schema15.xml,
loadOnStartup=true, configSetProperties=configsetprops.json,
instanceDir=collection1, collection=collection1,
absoluteInstDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/,
dataDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestStressReorder_3E5BE83C5675AACC-001/init-core-data-001,
shard=shard1}
[junit4] 2> 903059 INFO (coreLoadExecutor-3138-thread-1) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 903059 INFO (coreLoadExecutor-3138-thread-1) [ ]
o.a.s.c.SolrResourceLoader Adding
'file:/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/classes/'
to classloader
[junit4] 2> 903059 INFO (coreLoadExecutor-3138-thread-1) [ ]
o.a.s.c.SolrResourceLoader Adding
'file:/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/README'
to classloader
[junit4] 2> 903075 INFO (coreLoadExecutor-3138-thread-1) [ ]
o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 903078 INFO (coreLoadExecutor-3138-thread-1) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 903097 INFO (coreLoadExecutor-3138-thread-1) [ ]
o.a.s.c.Config Loaded SolrConfig: solrconfig-tlog.xml
[junit4] 2> 903098 INFO (coreLoadExecutor-3138-thread-1) [ ]
o.a.s.s.IndexSchema Reading Solr Schema from
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/schema15.xml
[junit4] 2> 903102 INFO (coreLoadExecutor-3138-thread-1) [ ]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 903172 INFO (coreLoadExecutor-3138-thread-1) [ ]
o.a.s.s.IndexSchema default search field in schema is text
[junit4] 2> 903173 INFO (coreLoadExecutor-3138-thread-1) [ ]
o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 903173 INFO (coreLoadExecutor-3138-thread-1) [ ]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 903175 INFO (coreLoadExecutor-3138-thread-1) [ ]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 903178 INFO (coreLoadExecutor-3138-thread-1) [ ]
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default
properties: Can't find resource 'configsetprops.json' in classpath or
'/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf'
[junit4] 2> 903179 INFO (coreLoadExecutor-3138-thread-1) [ ]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
instancedir
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/
[junit4] 2> 903179 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 903179 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/],
dataDir=[null]
[junit4] 2> 903179 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr
mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@117c8d7
[junit4] 2> 903179 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestStressReorder_3E5BE83C5675AACC-001/init-core-data-001
[junit4] 2> 903179 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null
new=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestStressReorder_3E5BE83C5675AACC-001/init-core-data-001/index/
[junit4] 2> 903179 WARN (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory
'/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestStressReorder_3E5BE83C5675AACC-001/init-core-data-001/index'
doesn't exist. Creating new index...
[junit4] 2> 903180 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestStressReorder_3E5BE83C5675AACC-001/init-core-data-001/index
[junit4] 2> 903180 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=12, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.7241196625547991]
[junit4] 2> 903180 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@7b1402
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ce6b2d),segFN=segments_1,generation=1}
[junit4] 2> 903180 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 903180 INFO
(OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1]
o.a.s.c.SolrCore Looking for old index directories to cleanup for core
collection1 in
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestStressReorder_3E5BE83C5675AACC-001/init-core-data-001/
[junit4] 2> 903182 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 903182 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 903182 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 903182 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 903182 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 903183 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 903183 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 903183 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 903183 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as
default, creating implicit default
[junit4] 2> 903184 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 903185 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 903185 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 903186 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 903188 INFO (coreLoadExecutor-3138-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> 903188 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.c.SolrCore Using default statsCache cache:
org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 903188 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 903188 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 903189 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
[junit4] 2> 903189 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
[junit4] 2> 903189 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=42, maxMergeAtOnceExplicit=32, maxMergedSegmentMB=92.2421875,
floorSegmentMB=1.474609375, forceMergeDeletesPctAllowed=19.289124194494224,
segmentsPerTier=45.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 903189 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@7b1402
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ce6b2d),segFN=segments_1,generation=1}
[junit4] 2> 903190 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 903190 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@54c892[collection1]
main
[junit4] 2> 903190 WARN (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf;
switching to use InMemory storage instead.
[junit4] 2> 903190 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
[junit4] 2> 903190 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using
InMemoryStorage
[junit4] 2> 903190 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 903190 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 903191 INFO
(searcherExecutor-3139-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@54c892[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 903191 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed
version buckets
[junit4] 2> 903191 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for
65536 version buckets from index
[junit4] 2> 903191 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed
version bucket highest value from index
[junit4] 2> 903191 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1509002850485665792
[junit4] 2> 903193 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.u.UpdateLog Took 1.0ms to seed version buckets with
highest version 1509002850485665792
[junit4] 2> 903193 INFO (coreLoadExecutor-3138-thread-1) [
x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 903194 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 903196 INFO
(TEST-TestStressReorder.testStressReorderVersions-seed#[3E5BE83C5675AACC]) [
] o.a.s.SolrTestCaseJ4 ###Starting testStressReorderVersions
[junit4] 2> 903196 INFO
(TEST-TestStressReorder.testStressReorderVersions-seed#[3E5BE83C5675AACC]) [
] o.a.s.c.SolrCore [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 903196 INFO
(TEST-TestStressReorder.testStressReorderVersions-seed#[3E5BE83C5675AACC]) [
] o.a.s.s.SolrIndexSearcher Opening Searcher@1f3a090[collection1] realtime
[junit4] 2> 903196 INFO
(TEST-TestStressReorder.testStressReorderVersions-seed#[3E5BE83C5675AACC]) [
] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
{deleteByQuery=*:* (-9223372036854775807)} 0 0
[junit4] 2> 903197 INFO
(TEST-TestStressReorder.testStressReorderVersions-seed#[3E5BE83C5675AACC]) [
] o.a.s.u.UpdateHandler start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 903197 INFO
(TEST-TestStressReorder.testStressReorderVersions-seed#[3E5BE83C5675AACC]) [
] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@7b1402
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ce6b2d),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@7b1402
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ce6b2d),segFN=segments_2,generation=2}
[junit4] 2> 903197 INFO
(TEST-TestStressReorder.testStressReorderVersions-seed#[3E5BE83C5675AACC]) [
] o.a.s.c.SolrCore newest commit generation = 2
[junit4] 2> 903198 INFO
(TEST-TestStressReorder.testStressReorderVersions-seed#[3E5BE83C5675AACC]) [
] o.a.s.s.SolrIndexSearcher Opening Searcher@1566718[collection1] main
[junit4] 2> 903198 INFO
(TEST-TestStressReorder.testStressReorderVersions-seed#[3E5BE83C5675AACC]) [
] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 903198 INFO (searcherExecutor-3139-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@1566718[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 903198 INFO
(TEST-TestStressReorder.testStressReorderVersions-seed#[3E5BE83C5675AACC]) [
] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={}
{commit=} 0 1
[junit4] 2> 903200 INFO
(TEST-TestStressReorder.testStressReorderVersions-seed#[3E5BE83C5675AACC]) [
] o.a.s.s.TestStressReorder VERBOSE: commitPercent 16 softCommitPercent 63
deletePercent 12 deleteByQueryPercent 7 ndocs 12 nWriteThreads 16
percentRealtimeQuery 75 operations 50000 nReadThreads 15
[junit4] 2> 903203 INFO (WRITER0) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 0 val= 2 version 1
[junit4] 2> 903203 INFO (WRITER2) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 11 val= 2 version 2
[junit4] 2> 903203 INFO (WRITER3) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 6 val= 2 version 3
[junit4] 2> 903203 INFO (WRITER1) [ ] o.a.s.s.TestStressReorder
VERBOSE: softCommit start
[junit4] 2> 903204 INFO (WRITER5) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 6 val= 2 version 5
[junit4] 2> 903204 INFO (WRITER4) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 6 val= 2 version 4
[junit4] 2> 903204 INFO (WRITER1) [ ] o.a.s.u.UpdateHandler start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 903204 INFO (WRITER11) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 6 val= 2 version 10
[junit4] 2> 903204 INFO (WRITER8) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 6 val= 2 version 12
[junit4] 2> 903204 INFO (WRITER12) [ ] o.a.s.s.TestStressReorder
VERBOSE: deleteByQuery id 6 val= 2 version 11
[junit4] 2> 903204 INFO (WRITER10) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 6 val= 2 version 9
[junit4] 2> 903204 INFO (WRITER9) [ ] o.a.s.s.TestStressReorder
VERBOSE: deleting id 6 val= 2 version 8
[junit4] 2> 903204 INFO (WRITER7) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 7 val= 2 version 7
[junit4] 2> 903204 INFO (WRITER6) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 6 val= 2 version 6
[junit4] 2> 903206 INFO (WRITER0) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[0
(1)]} 0 2
[junit4] 2> 903206 INFO (WRITER14) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 6 val= 2 version 14
[junit4] 2> 903206 INFO (WRITER0) [ ] o.a.s.s.TestStressReorder
VERBOSE: deleteByQuery id 7 val= 2 version 15
[junit4] 2> 903206 INFO (WRITER5) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[6
(5)]} 0 1
[junit4] 2> 903206 INFO (WRITER11) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[6
(10)]} 0 1
[junit4] 2> 903206 INFO (WRITER4) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[6
(4)]} 0 1
[junit4] 2> 903206 INFO (WRITER8) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[6
(12)]} 0 1
[junit4] 2> 903206 INFO (WRITER10) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[6
(9)]} 0 1
[junit4] 2> 903207 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=6&wt=json} status=0 QTime=0
[junit4] 2> 903205 INFO (WRITER13) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 2 val= 2 version 13
[junit4] 2> 903206 INFO (WRITER2) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[11
(2)]} 0 2
[junit4] 2> 903206 INFO (WRITER3) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[6
(3)]} 0 1
[junit4] 2> 903208 INFO (WRITER2) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 11 val= 3 version 19
[junit4] 2> 903207 INFO (WRITER10) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 4 val= 2 version 18
[junit4] 2> 903207 INFO (WRITER8) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 1 val= 2 version 17
[junit4] 2> 903207 INFO (WRITER4) [ ] o.a.s.s.TestStressReorder
VERBOSE: hardCommit start
[junit4] 2> 903207 INFO (WRITER11) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 6 val= 3 version 16
[junit4] 2> 903207 INFO (WRITER15) [ ] o.a.s.s.TestStressReorder
VERBOSE: softCommit start
[junit4] 2> 903207 INFO (WRITER5) [ ] o.a.s.s.TestStressReorder
VERBOSE: softCommit start
[junit4] 2> 903208 INFO (WRITER3) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 11 val= 3 version 20
[junit4] 2> 903208 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
[junit4] 2> 903208 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=6&wt=json} status=0 QTime=0
[junit4] 2> 903209 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=9&wt=json} status=0 QTime=0
[junit4] 2> 903209 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=0
[junit4] 2> 903210 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=8&wt=json} status=0 QTime=0
[junit4] 2> 903210 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:5&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903210 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903210 INFO (READER2) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903210 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:0&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903210 INFO (WRITER1) [ ] o.a.s.s.SolrIndexSearcher
Opening Searcher@77eae1[collection1] main
[junit4] 2> 903210 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:9&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903210 INFO (WRITER1) [ ] o.a.s.u.UpdateHandler
end_commit_flush
[junit4] 2> 903210 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
[junit4] 2> 903210 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
[junit4] 2> 903210 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:11&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903211 INFO (searcherExecutor-3139-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@77eae1[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c1)))}
[junit4] 2> 903210 INFO (READER2) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
[junit4] 2> 903211 INFO (READER2) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=8&wt=json} status=0 QTime=0
[junit4] 2> 903211 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903211 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:10&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903211 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:8&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903211 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=8&wt=json} status=0 QTime=0
[junit4] 2> 903211 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903211 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
[junit4] 2> 903211 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=6&wt=json} status=0 QTime=0
[junit4] 2> 903212 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:8&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903212 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=5&wt=json} status=0 QTime=0
[junit4] 2> 903212 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
[junit4] 2> 903212 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=0
[junit4] 2> 903212 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=0
[junit4] 2> 903214 INFO (READER10) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
[junit4] 2> 903214 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
[junit4] 2> 903214 INFO (READER10) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
[junit4] 2> 903214 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=5&wt=json} status=0 QTime=0
[junit4] 2> 903214 INFO (READER10) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
[junit4] 2> 903214 INFO (READER13) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=5&wt=json} status=0 QTime=0
[junit4] 2> 903214 INFO (READER10) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
[junit4] 2> 903215 INFO (READER13) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
[junit4] 2> 903214 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
[junit4] 2> 903215 INFO (READER13) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
[junit4] 2> 903214 INFO (READER11) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
[junit4] 2> 903215 INFO (READER13) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=10&wt=json} status=0 QTime=0
[junit4] 2> 903215 INFO (READER11) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
[junit4] 2> 903214 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
[junit4] 2> 903215 INFO (READER11) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
[junit4] 2> 903215 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=10&wt=json} status=0 QTime=0
[junit4] 2> 903215 INFO (READER11) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
[junit4] 2> 903215 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
[junit4] 2> 903215 INFO (READER11) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
[junit4] 2> 903215 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
[junit4] 2> 903215 INFO (READER11) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=6&wt=json} status=0 QTime=0
[junit4] 2> 903216 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
[junit4] 2> 903214 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=5&wt=json} status=0 QTime=0
[junit4] 2> 903216 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903216 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=8&wt=json} status=0 QTime=0
[junit4] 2> 903216 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=5&wt=json} status=0 QTime=0
[junit4] 2> 903216 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
[junit4] 2> 903216 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
[junit4] 2> 903216 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
[junit4] 2> 903214 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=8&wt=json} status=0 QTime=0
[junit4] 2> 903214 INFO (READER6) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=5&wt=json} status=0 QTime=0
[junit4] 2> 903216 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=10&wt=json} status=0 QTime=0
[junit4] 2> 903216 INFO (READER6) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=8&wt=json} status=0 QTime=0
[junit4] 2> 903216 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
[junit4] 2> 903214 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:5&omitHeader=true&wt=json} hits=0 status=0
QTime=1
[junit4] 2> 903217 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:6&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903217 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
[junit4] 2> 903214 INFO (READER2) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:11&omitHeader=true&wt=json} hits=1 status=0
QTime=2
[junit4] 2> 903217 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=10&wt=json} status=0 QTime=0
[junit4] 2> 903214 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:11&omitHeader=true&wt=json} hits=1 status=0
QTime=3
[junit4] 2> 903217 INFO (READER2) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
[junit4] 2> 903213 INFO (WRITER1) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null params={} {commit=} 0 8
[junit4] 2> 903217 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=0
[junit4] 2> 903218 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:11&omitHeader=true&wt=json} hits=1 status=0
QTime=7
[junit4] 2> 903218 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:11&omitHeader=true&wt=json} hits=1 status=0
QTime=0
[junit4] 2> 903217 INFO (READER2) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
[junit4] 2> 903218 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
[junit4] 2> 903217 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903222 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:11&omitHeader=true&wt=json} hits=1 status=0
QTime=3
[junit4] 2> 903217 INFO (READER6) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903216 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:9&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903215 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:3&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903214 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:3&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903223 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:10&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903223 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:0&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903222 INFO (READER13) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:11&omitHeader=true&wt=json} hits=1 status=0
QTime=7
[junit4] 2> 903220 INFO (READER11) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:11&omitHeader=true&wt=json} hits=1 status=0
QTime=4
[junit4] 2> 903224 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:8&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903219 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:11&omitHeader=true&wt=json} hits=1 status=0
QTime=3
[junit4] 2> 903219 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:11&omitHeader=true&wt=json} hits=1 status=0
QTime=2
[junit4] 2> 903224 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903219 INFO (READER10) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:11&omitHeader=true&wt=json} hits=1 status=0
QTime=4
[junit4] 2> 903218 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=8&wt=json} status=0 QTime=0
[junit4] 2> 903218 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:10&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903218 INFO (READER2) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
[junit4] 2> 903223 INFO (WRITER1) [ ] o.a.s.s.TestStressReorder
VERBOSE: softCommit end
[junit4] 2> 903223 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903223 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:11&omitHeader=true&wt=json} hits=1 status=0
QTime=11
[junit4] 2> 903225 INFO (WRITER1) [ ] o.a.s.s.TestStressReorder
VERBOSE: hardCommit start
[junit4] 2> 903225 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:11&omitHeader=true&wt=json} hits=1 status=0
QTime=0
[junit4] 2> 903226 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:6&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903228 INFO (WRITER12) [ ] o.a.s.s.SolrIndexSearcher
Opening Searcher@d93d15[collection1] realtime
[junit4] 2> 903228 INFO (WRITER12) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={_version_=-11&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
{deleteByQuery=id:6 (-11)} 0 22
[junit4] 2> 903228 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=10&wt=json} status=0 QTime=3
[junit4] 2> 903228 INFO (WRITER7) [ ] o.a.s.u.UpdateHandler Reordered
DBQs detected. Update=add{_version_=7,id=7} DBQs=[DBQ{version=11,q=id:6}]
[junit4] 2> 903228 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
[junit4] 2> 903228 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=2
[junit4] 2> 903228 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
[junit4] 2> 903228 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=9&wt=json} status=0 QTime=0
[junit4] 2> 903228 INFO (WRITER12) [ ] o.a.s.s.TestStressReorder
VERBOSE: deleteByQuery id 6 val= 2 version 11 DONE
[junit4] 2> 903229 INFO (READER10) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=4
[junit4] 2> 903228 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=8&wt=json} status=0 QTime=2
[junit4] 2> 903228 INFO (READER2) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=3
[junit4] 2> 903229 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=4
[junit4] 2> 903229 INFO (WRITER12) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 6 val= 3 version 21
[junit4] 2> 903229 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
[junit4] 2> 903229 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=2
[junit4] 2> 903228 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
[junit4] 2> 903229 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:10&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903230 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:6&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903232 INFO (WRITER7) [ ] o.a.s.s.SolrIndexSearcher
Opening Searcher@c46cdb[collection1] realtime
[junit4] 2> 903232 INFO (WRITER7) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[7
(7)]} 0 26
[junit4] 2> 903232 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=8
[junit4] 2> 903232 INFO (WRITER7) [ ] o.a.s.s.TestStressReorder
VERBOSE: softCommit start
[junit4] 2> 903232 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
[junit4] 2> 903233 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:3&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903233 INFO (READER6) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=10
[junit4] 2> 903233 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:11&omitHeader=true&wt=json} hits=1 status=0
QTime=0
[junit4] 2> 903234 INFO (READER6) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=0
[junit4] 2> 903234 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=5&wt=json} status=0 QTime=10
[junit4] 2> 903234 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:7&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903233 INFO (READER13) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=9
[junit4] 2> 903234 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=10
[junit4] 2> 903234 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=11
[junit4] 2> 903234 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=8&wt=json} status=0 QTime=0
[junit4] 2> 903235 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=0
[junit4] 2> 903235 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=6&wt=json} status=0 QTime=4
[junit4] 2> 903233 INFO (READER11) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=9
[junit4] 2> 903235 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=8&wt=json} status=0 QTime=5
[junit4] 2> 903233 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=10
[junit4] 2> 903236 INFO (READER11) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:0&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903236 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:3&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903236 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=6&wt=json} status=0 QTime=0
[junit4] 2> 903236 INFO (READER11) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=0
[junit4] 2> 903235 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=0
[junit4] 2> 903235 INFO (WRITER9) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={_version_=-8&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
{delete=[6 (-8)]} 0 30
[junit4] 2> 903235 INFO (READER2) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=6&wt=json} status=0 QTime=6
[junit4] 2> 903235 INFO (READER10) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=6&wt=json} status=0 QTime=6
[junit4] 2> 903235 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=0
[junit4] 2> 903235 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=6
[junit4] 2> 903235 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=10&wt=json} status=0 QTime=0
[junit4] 2> 903235 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=5
[junit4] 2> 903235 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=6&wt=json} status=0 QTime=4
[junit4] 2> 903235 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=5&wt=json} status=0 QTime=0
[junit4] 2> 903234 INFO (READER13) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
[junit4] 2> 903234 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:9&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903234 INFO (READER6) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:7&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903237 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903237 INFO (WRITER9) [ ] o.a.s.s.TestStressReorder
VERBOSE: deleting id 6 val= 2 version 8 DONE
[junit4] 2> 903236 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=0
[junit4] 2> 903236 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903236 INFO (WRITER6) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[6
(6)]} 0 30
[junit4] 2> 903236 INFO (WRITER14) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[6
(14)]} 0 30
[junit4] 2> 903238 INFO (WRITER6) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 7 val= 3 version 23
[junit4] 2> 903238 INFO (WRITER14) [ ] o.a.s.s.TestStressReorder
VERBOSE: deleting id 6 val= 3 version 24
[junit4] 2> 903238 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:0&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903238 INFO (WRITER9) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 7 val= 3 version 22
[junit4] 2> 903238 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:0&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903239 INFO (WRITER0) [ ] o.a.s.s.SolrIndexSearcher
Opening Searcher@702f6a[collection1] realtime
[junit4] 2> 903239 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=1
[junit4] 2> 903239 INFO (WRITER4) [ ] o.a.s.u.UpdateHandler start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 903240 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=6&wt=json} status=0 QTime=3
[junit4] 2> 903240 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:8&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903241 INFO (WRITER7) [ ] o.a.s.u.UpdateHandler start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 903240 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=6&wt=json} status=0 QTime=1
[junit4] 2> 903240 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=2
[junit4] 2> 903241 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
[junit4] 2> 903240 INFO (READER6) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=2
[junit4] 2> 903241 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:6&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903240 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=2
[junit4] 2> 903240 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=2
[junit4] 2> 903242 INFO (WRITER6) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[7
(23)]} 0 3
[junit4] 2> 903240 INFO (WRITER5) [ ] o.a.s.u.UpdateHandler start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 903240 INFO (WRITER15) [ ] o.a.s.u.UpdateHandler start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 903242 INFO (WRITER6) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 6 val= 3 version 25
[junit4] 2> 903240 INFO (READER13) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=2
[junit4] 2> 903239 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=1
[junit4] 2> 903239 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=1
[junit4] 2> 903243 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
[junit4] 2> 903243 INFO (READER13) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:6&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903243 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=8&wt=json} status=0 QTime=0
[junit4] 2> 903242 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=5&wt=json} status=0 QTime=0
[junit4] 2> 903242 INFO (WRITER9) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[7
(22)]} 0 3
[junit4] 2> 903241 INFO (WRITER4) [ ] o.a.s.c.SolrCore
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@7b1402
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ce6b2d),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@7b1402
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ce6b2d),segFN=segments_3,generation=3}
[junit4] 2> 903243 INFO (WRITER4) [ ] o.a.s.c.SolrCore newest commit
generation = 3
[junit4] 2> 903241 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
[junit4] 2> 903244 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=9&wt=json} status=0 QTime=0
[junit4] 2> 903244 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:1&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903244 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=6
[junit4] 2> 903244 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=9&wt=json} status=0 QTime=0
[junit4] 2> 903244 INFO (READER6) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=3
[junit4] 2> 903244 INFO (WRITER13) [ ] o.a.s.u.UpdateHandler Reordered
DBQs detected. Update=add{_version_=13,id=2} DBQs=[DBQ{version=15,q=id:7}]
[junit4] 2> 903244 INFO (READER6) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=10&wt=json} status=0 QTime=0
[junit4] 2> 903243 INFO (WRITER9) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 9 val= 2 version 26
[junit4] 2> 903245 INFO (READER6) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=0
[junit4] 2> 903245 INFO (WRITER10) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[4
(18)]} 0 36
[junit4] 2> 903245 INFO (WRITER9) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[9
(26)]} 0 0
[junit4] 2> 903245 INFO (READER6) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:5&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903243 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=6&wt=json} status=0 QTime=0
[junit4] 2> 903245 INFO (READER6) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
[junit4] 2> 903243 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
[junit4] 2> 903245 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:11&omitHeader=true&wt=json} hits=1 status=0
QTime=0
[junit4] 2> 903245 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=10&wt=json} status=0 QTime=0
[junit4] 2> 903245 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
[junit4] 2> 903246 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=10&wt=json} status=0 QTime=0
[junit4] 2> 903243 INFO (READER13) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:9&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903243 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
[junit4] 2> 903246 INFO (READER13) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=5&wt=json} status=0 QTime=0
[junit4] 2> 903246 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
[junit4] 2> 903246 INFO (READER13) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
[junit4] 2> 903246 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=10&wt=json} status=0 QTime=0
[junit4] 2> 903246 INFO (READER13) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=8&wt=json} status=0 QTime=0
[junit4] 2> 903246 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=10&wt=json} status=0 QTime=0
[junit4] 2> 903246 INFO (READER13) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
[junit4] 2> 903246 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
[junit4] 2> 903246 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:10&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903246 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=10&wt=json} status=0 QTime=0
[junit4] 2> 903247 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=9&wt=json} status=0 QTime=0
[junit4] 2> 903247 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=10&wt=json} status=0 QTime=0
[junit4] 2> 903247 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
[junit4] 2> 903247 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=10&wt=json} status=0 QTime=0
[junit4] 2> 903245 INFO (WRITER12) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[6
(21)]} 0 16
[junit4] 2> 903247 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:8&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903245 INFO (WRITER14) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={_version_=-24&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
{delete=[6 (-24)]} 0 7
[junit4] 2> 903245 INFO (WRITER7) [ ] o.a.s.s.SolrIndexSearcher
Opening Searcher@1488ffd[collection1] main
[junit4] 2> 903245 INFO (READER6) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:6&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903245 INFO (WRITER9) [ ] o.a.s.s.TestStressReorder
VERBOSE: deleting id 10 val= 2 version 28
[junit4] 2> 903248 INFO (searcherExecutor-3139-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@1488ffd[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c1)
Uninverting(_1(6.0.0):c3/2:delGen=2) Uninverting(_4(6.0.0):c1)
Uninverting(_5(6.0.0):c1)))}
[junit4] 2> 903245 INFO (WRITER10) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 9 val= 2 version 27
[junit4] 2> 903245 INFO (WRITER3) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[11
(20)]} 0 36
[junit4] 2> 903245 INFO (WRITER6) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[6
(25)]} 0 2
[junit4] 2> 903245 INFO (WRITER8) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[1
(17)]} 0 36
[junit4] 2> 903245 INFO (WRITER2) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[11
(19)]} 0 36
[junit4] 2> 903245 INFO (WRITER11) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[6
(16)]} 0 36
[junit4] 2> 903244 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=0
[junit4] 2> 903244 INFO (WRITER0) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={_version_=-15&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
{deleteByQuery=id:7 (-15)} 0 38
[junit4] 2> 903244 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=6&wt=json} status=0 QTime=3
[junit4] 2> 903244 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=5&wt=json} status=0 QTime=2
[junit4] 2> 903244 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=6&wt=json} status=0 QTime=2
[junit4] 2> 903250 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:5&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903244 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=2
[junit4] 2> 903244 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=9&wt=json} status=0 QTime=0
[junit4] 2> 903244 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=7
[junit4] 2> 903244 INFO (READER11) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=6&wt=json} status=0 QTime=7
[junit4] 2> 903244 INFO (READER2) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=7
[junit4] 2> 903244 INFO (READER10) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=8&wt=json} status=0 QTime=7
[junit4] 2> 903251 INFO (READER11) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:7&omitHeader=true&wt=json} hits=1 status=0
QTime=0
[junit4] 2> 903251 INFO (READER2) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903250 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:6&omitHeader=true&wt=json} hits=1 status=0
QTime=0
[junit4] 2> 903250 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:5&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903250 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:6&omitHeader=true&wt=json} hits=1 status=0
QTime=0
[junit4] 2> 903250 INFO (WRITER0) [ ] o.a.s.s.TestStressReorder
VERBOSE: deleteByQuery id 7 val= 2 version 15 DONE
[junit4] 2> 903249 INFO (WRITER11) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 6 val= 4 version 33
[junit4] 2> 903249 INFO (WRITER2) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 11 val= 4 version 32
[junit4] 2> 903249 INFO (WRITER8) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 3 val= 2 version 31
[junit4] 2> 903249 INFO (WRITER6) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 11 val= 4 version 30
[junit4] 2> 903249 INFO (WRITER3) [ ] o.a.s.s.TestStressReorder
VERBOSE: softCommit start
[junit4] 2> 903248 INFO (WRITER7) [ ] o.a.s.u.UpdateHandler
end_commit_flush
[junit4] 2> 903251 INFO (WRITER3) [ ] o.a.s.u.UpdateHandler start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 903247 INFO (WRITER14) [ ] o.a.s.s.TestStressReorder
VERBOSE: deleting id 6 val= 3 version 24 DONE
[junit4] 2> 903247 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
[junit4] 2> 903247 INFO (WRITER12) [ ] o.a.s.s.TestStressReorder
VERBOSE: deleteByQuery id 8 val= 2 version 29
[junit4] 2> 903247 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:10&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903246 INFO (READER13) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:7&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903246 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
[junit4] 2> 903253 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:7&omitHeader=true&wt=json} hits=1 status=0
QTime=0
[junit4] 2> 903252 INFO (WRITER14) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 9 val= 3 version 34
[junit4] 2> 903251 INFO (WRITER7) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null params={} {commit=} 0 19
[junit4] 2> 903251 INFO (WRITER0) [ ] o.a.s.s.TestStressReorder
VERBOSE: softCommit start
[junit4] 2> 903253 INFO (WRITER13) [ ] o.a.s.s.SolrIndexSearcher
Opening Searcher@1dbf83b[collection1] realtime
[junit4] 2> 903254 INFO (WRITER13) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[2
(13)]} 0 46
[junit4] 2> 903254 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=1
[junit4] 2> 903254 INFO (WRITER13) [ ] o.a.s.s.TestStressReorder
VERBOSE: softCommit start
[junit4] 2> 903254 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=10&wt=json} status=0 QTime=0
[junit4] 2> 903254 INFO (READER13) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
[junit4] 2> 903254 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
[junit4] 2> 903255 INFO (READER13) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
[junit4] 2> 903255 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
[junit4] 2> 903255 INFO (READER13) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
[junit4] 2> 903255 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=8&wt=json} status=0 QTime=2
[junit4] 2> 903255 INFO (READER13) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=9&wt=json} status=0 QTime=0
[junit4] 2> 903255 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
[junit4] 2> 903255 INFO (READER13) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
[junit4] 2> 903255 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903255 INFO (READER13) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:6&omitHeader=true&wt=json} hits=1 status=0
QTime=0
[junit4] 2> 903255 INFO (WRITER7) [ ] o.a.s.s.TestStressReorder
VERBOSE: softCommit end
[junit4] 2> 903255 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
[junit4] 2> 903255 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
[junit4] 2> 903255 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=6&wt=json} status=0 QTime=2
[junit4] 2> 903256 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:9&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903256 INFO (READER13) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=9&wt=json} status=0 QTime=0
[junit4] 2> 903256 INFO (WRITER7) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 2 val= 3 version 35
[junit4] 2> 903256 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=9&wt=json} status=0 QTime=5
[junit4] 2> 903256 INFO (READER13) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:11&omitHeader=true&wt=json} hits=1 status=0
QTime=0
[junit4] 2> 903256 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=5
[junit4] 2> 903256 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=6&wt=json} status=0 QTime=0
[junit4] 2> 903256 INFO (READER11) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=8&wt=json} status=0 QTime=5
[junit4] 2> 903256 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
[junit4] 2> 903256 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=4
[junit4] 2> 903257 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=8&wt=json} status=0 QTime=0
[junit4] 2> 903258 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=6&wt=json} status=0 QTime=7
[junit4] 2> 903258 INFO (WRITER10) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[9
(27)]} 0 8
[junit4] 2> 903258 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
[junit4] 2> 903258 INFO (WRITER10) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 4 val= 3 version 36
[junit4] 2> 903258 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
[junit4] 2> 903256 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:9&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903256 INFO (WRITER11) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[6
(33)]} 0 4
[junit4] 2> 903258 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
[junit4] 2> 903258 INFO (WRITER9) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={_version_=-28&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
{delete=[10 (-28)]} 0 10
[junit4] 2> 903258 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
[junit4] 2> 903258 INFO (WRITER9) [ ] o.a.s.s.TestStressReorder
VERBOSE: deleting id 10 val= 2 version 28 DONE
[junit4] 2> 903258 INFO (WRITER9) [ ] o.a.s.s.TestStressReorder
VERBOSE: deleteByQuery id 4 val= 3 version 37
[junit4] 2> 903259 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:10&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903259 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=8&wt=json} status=0 QTime=0
[junit4] 2> 903259 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:11&omitHeader=true&wt=json} hits=1 status=0
QTime=0
[junit4] 2> 903259 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:5&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 903259 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
[junit4] 2> 903259 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
[junit4] 2> 903260 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
[junit4] 2> 903260 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=6&wt=json} status=0 QTime=0
[junit4] 2> 903260 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:6&omitHeader=true&wt=json} hits=1 status=0
QTime=0
[junit4] 2> 903260 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
[junit4] 2> 903260 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=8&wt=json} status=0 QTime=0
[junit4] 2> 903261 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=0
[junit4] 2> 903261 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
[junit4] 2> 903261 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=0&wt=json} status=0 QTime=0
[junit4] 2> 903261 INFO (WRITER4) [ ] o.a.s.s.SolrIndexSearcher
Opening Searcher@1954fbd[collection1] main
[junit4] 2> 903256 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=9&wt=json} status=0 QTime=0
[junit4] 2> 903262 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=9&wt=json} status=0 QTime=0
[junit4] 2> 903262 INFO (searcherExecutor-3139-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@1954fbd[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):c3/2:delGen=2)
Uninverting(_5(6.0.0):c1) Uninverting(_8(6.0.0):c5/3)
Uninverting(_9(6.0.0):c1) Uninverting(_a(6.0.0):c1) Uninverting(_b(6.0.0):c3)))}
[junit4] 2> 903262 INFO (WRITER15) [ ] o.a.s.c.SolrCore
SolrIndexSearcher has not changed - not re-opening:
org.apache.solr.search.SolrIndexSearcher
[junit4] 2> 903262 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:4&omitHeader=true&wt=json} hits=1 status=0
QTime=0
[junit4] 2> 903262 INFO (WRITER5) [ ] o.a.s.c.SolrCore
SolrIndexSearcher has not changed - not re-opening:
org.apache.solr.search.SolrIndexSearcher
[junit4] 2> 903262 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
[junit4] 2> 903262 INFO (WRITER3) [ ] o.a.s.c.SolrCore
SolrIndexSearcher has not changed - not re-opening:
org.apache.solr.search.SolrIndexSearcher
[junit4] 2> 903262 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
[junit4] 2> 903262 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
[junit4] 2> 903263 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
[junit4] 2> 903263 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=8&wt=json} status=0 QTime=0
[junit4] 2> 903263 INFO (READER12) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
[junit4] 2> 903256 INFO (WRITER8) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[3
(31)]} 0 4
[junit4] 2> 903262 INFO (WRITER3) [ ] o.a.s.u.UpdateHandler
end_commit_flush
[junit4] 2> 903262 INFO (WRITER5) [ ] o.a.s.u.UpdateHandler
end_commit_flush
[junit4] 2> 903262 INFO (WRITER15) [ ] o.a.s.u.UpdateHandler
end_commit_flush
[junit4] 2> 903261 INFO (WRITER4) [ ] o.a.s.u.UpdateHandler
end_commit_flush
[junit4] 2> 903261 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
[junit4] 2> 903264 INFO (WRITER1) [ ] o.a.s.u.UpdateHandler start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 903258 INFO (WRITER11) [ ] o.a.s.s.TestStressReorder
VERBOSE: softCommit start
[junit4] 2> 903264 INFO (READER14) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
[junit4] 2> 903258 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=0
[junit4] 2> 903258 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:11&omitHeader=true&wt=json} hits=1 status=0
QTime=0
[junit4] 2> 903258 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
[junit4] 2> 903264 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
[junit4] 2> 903264 INFO (WRITER1) [ ] o.a.s.c.SolrCore
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@7b1402
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ce6b2d),segFN=segments_3,generation=3}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@7b1402
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ce6b2d),segFN=segments_4,generation=4}
[junit4] 2> 903264 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=9&wt=json} status=0 QTime=0
[junit4] 2> 903258 INFO (WRITER2) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[11
(32)]} 0 6
[junit4] 2> 903265 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
[junit4] 2> 903265 INFO (WRITER2) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 3 val= 3 version 39
[junit4] 2> 903265 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=5&wt=json} status=0 QTime=0
[junit4] 2> 903258 INFO (WRITER6) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[11
(30)]} 0 6
[junit4] 2> 903258 INFO (READER6) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=9
[junit4] 2> 903257 INFO (READER10) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=6
[junit4] 2> 903257 INFO (READER11) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:0&omitHeader=true&wt=json} hits=1 status=0
QTime=0
[junit4] 2> 903257 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=6
[junit4] 2> 903266 INFO (READER10) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=7&wt=json} status=0 QTime=0
[junit4] 2> 903266 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:0&omitHeader=true&wt=json} hits=1 status=0
QTime=0
[junit4] 2> 903266 INFO (READER10) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
[junit4] 2> 903267 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
[junit4] 2> 903267 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:11&omitHeader=true&wt=json} hits=1 status=0
QTime=0
[junit4] 2> 903267 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
[junit4] 2> 903267 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
[junit4] 2> 903257 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=6&wt=json} status=0 QTime=7
[junit4] 2> 903257 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=6&wt=json} status=0 QTime=6
[junit4] 2> 903257 INFO (READER2) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=5
[junit4] 2> 903268 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
[junit4] 2> 903268 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=1&wt=json} status=0 QTime=0
[junit4] 2> 903268 INFO (READER2) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:6&omitHeader=true&wt=json} hits=1 status=0
QTime=0
[junit4] 2> 903268 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:9&omitHeader=true&wt=json} hits=1 status=0
QTime=0
[junit4] 2> 903256 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
[junit4] 2> 903256 INFO (READER13) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=2&wt=json} status=0 QTime=0
[junit4] 2> 903256 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=8&wt=json} status=0 QTime=0
[junit4] 2> 903268 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=6&wt=json} status=0 QTime=0
[junit4] 2> 903269 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
[junit4] 2> 903268 INFO (READER2) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=11&wt=json} status=0 QTime=0
[junit4] 2> 903268 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
[junit4] 2> 903268 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=1 status=0
QTime=0
[junit4] 2> 903267 INFO (READER10) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=4&wt=json} status=0 QTime=0
[junit4] 2> 903269 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:3&omitHeader=true&wt=json} hits=1 status=0
QTime=0
[junit4] 2> 903269 INFO (READER10) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=8&wt=json} status=0 QTime=0
[junit4] 2> 903266 INFO (READER6) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=1
[junit4] 2> 903288 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={qt=/get&ids=3&wt=json} status=0 QTime=0
[junit4] 2> 903288 INFO (READER10) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:2&omitHeader=true&wt=json} hits=1 status=0
QTime=0
[junit4] 2> 903265 INFO (WRITER6) [ ] o.a.s.s.TestStressReorder
VERBOSE: adding id 3 val= 3 version 40
[junit4] 2> 903288 INFO (READER10) [ ] o.a.s.c.S.Request [collection1]
webapp
[...truncated too long message...]
05297 INFO (WRITER15) [ ] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 905297 INFO (WRITER15) [ ] o.a.s.u.p.LogUpdateProcessor
[collection1] webapp=null path=null params={} {commit=} 0 17
[junit4] 2> ago 09, 2015 10:14:23 AM
com.carrotsearch.randomizedtesting.RandomizedRunner$QueueUncaughtExceptionsHandler
uncaughtException
[junit4] 2> ADVERTĂNCIA: Uncaught exception in thread:
Thread[READER4,5,TGRP-TestStressReorder]
[junit4] 2> java.lang.RuntimeException: java.lang.AssertionError
[junit4] 2> at
__randomizedtesting.SeedInfo.seed([3E5BE83C5675AACC]:0)
[junit4] 2> at
org.apache.solr.search.TestStressReorder$2.run(TestStressReorder.java:316)
[junit4] 2> Caused by: java.lang.AssertionError
[junit4] 2> at org.junit.Assert.fail(Assert.java:92)
[junit4] 2> at org.junit.Assert.assertTrue(Assert.java:43)
[junit4] 2> at org.junit.Assert.assertTrue(Assert.java:54)
[junit4] 2> at
org.apache.solr.search.TestStressReorder$2.run(TestStressReorder.java:309)
[junit4] 2>
[junit4] 2> 905297 INFO (WRITER15) [ ] o.a.s.s.TestStressReorder
VERBOSE: hardCommit end
[junit4] 2> 905297 INFO
(TEST-TestStressReorder.testStressReorderVersions-seed#[3E5BE83C5675AACC]) [
] o.a.s.SolrTestCaseJ4 ###Ending testStressReorderVersions
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestStressReorder
-Dtests.method=testStressReorderVersions -Dtests.seed=3E5BE83C5675AACC
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=pt_BR
-Dtests.timezone=Asia/Baku -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 2.11s J1 | TestStressReorder.testStressReorderVersions <<<
[junit4] > Throwable #1:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught
exception in thread: Thread[id=7093, name=READER4, state=RUNNABLE,
group=TGRP-TestStressReorder]
[junit4] > at
__randomizedtesting.SeedInfo.seed([3E5BE83C5675AACC:229DD12A5CBE2E41]:0)
[junit4] > Caused by: java.lang.RuntimeException: java.lang.AssertionError
[junit4] > at
__randomizedtesting.SeedInfo.seed([3E5BE83C5675AACC]:0)
[junit4] > at
org.apache.solr.search.TestStressReorder$2.run(TestStressReorder.java:316)
[junit4] > Caused by: java.lang.AssertionError
[junit4] > at
org.apache.solr.search.TestStressReorder$2.run(TestStressReorder.java:309)
[junit4] 2> 905302 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 905302 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=25439390
[junit4] 2> 905302 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ x:collection1]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@14fb173
[junit4] 2> 905303 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ x:collection1]
o.a.s.u.UpdateHandler closing
DirectUpdateHandler2{commits=152,autocommits=0,soft
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=1,cumulative_adds=489,cumulative_deletesById=88,cumulative_deletesByQuery=65,cumulative_errors=1,transaction_logs_total_size=3621,transaction_logs_total_number=7}
[junit4] 2> 905303 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ x:collection1]
o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 905303 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ x:collection1]
o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing
IndexWriter
[junit4] 2> 905303 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ x:collection1]
o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
[junit4] 2> 905314 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ x:collection1]
o.a.s.c.SolrCore [collection1] Closing main searcher on request.
[junit4] 2> 905326 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ x:collection1]
o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories
currently being tracked
[junit4] 2> 905326 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ x:collection1]
o.a.s.c.CachingDirectoryFactory looking to close
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestStressReorder_3E5BE83C5675AACC-001/init-core-data-001/index
[CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestStressReorder_3E5BE83C5675AACC-001/init-core-data-001/index;done=false>>]
[junit4] 2> 905326 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ x:collection1]
o.a.s.c.CachingDirectoryFactory Closing directory:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestStressReorder_3E5BE83C5675AACC-001/init-core-data-001/index
[junit4] 2> 905326 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ x:collection1]
o.a.s.c.CachingDirectoryFactory looking to close
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestStressReorder_3E5BE83C5675AACC-001/init-core-data-001
[CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestStressReorder_3E5BE83C5675AACC-001/init-core-data-001;done=false>>]
[junit4] 2> 905327 INFO
(SUITE-TestStressReorder-seed#[3E5BE83C5675AACC]-worker) [ x:collection1]
o.a.s.c.CachingDirectoryFactory Closing directory:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.search.TestStressReorder_3E5BE83C5675AACC-001/init-core-data-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene53):
{val_l=PostingsFormat(name=LuceneVarGapDocFreqInterval),
_version_=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
id=PostingsFormat(name=LuceneVarGapFixedInterval)}, docValues:{},
sim=DefaultSimilarity, locale=pt_BR, timezone=Asia/Baku
[junit4] 2> NOTE: Linux 3.16.0-44-generic i386/Oracle Corporation
1.8.0_60-ea (32-bit)/cpus=12,threads=1,free=111420704,total=358543360
[junit4] 2> NOTE: All tests run in this JVM: [AliasIntegrationTest,
TestAtomicUpdateErrorCases, SolrCmdDistributorTest, TestDistributedMissingSort,
TestCharFilters, OpenCloseCoreStressTest, TestStandardQParsers, RankQueryTest,
BufferStoreTest, TestStressVersions, TestDynamicFieldResource,
TestSimpleQParserPlugin, TestPHPSerializedResponseWriter,
TestElisionMultitermQuery, TestLFUCache, TestCloudInspectUtil,
OverseerRolesTest, TestWriterPerf, BasicFunctionalityTest, TestConfigOverlay,
ReplicationFactorTest, DistanceFunctionTest, NoCacheHeaderTest,
TestOmitPositions, ShowFileRequestHandlerTest, HttpPartitionTest,
SolrXmlInZkTest, DisMaxRequestHandlerTest, TestFuzzyAnalyzedSuggestions,
DistributedFacetPivotLargeTest, FieldAnalysisRequestHandlerTest,
TestReplicaProperties, TestExpandComponent, TestLMDirichletSimilarityFactory,
TestSchemaManager, LeaderFailoverAfterPartitionTest, FileUtilsTest, TestRTimer,
DistributedFacetPivotSmallTest, TestConfigSets, EchoParamsTest,
TestBlobHandler, TestRestoreCore, TestSuggestSpellingConverter,
DistributedMLTComponentTest, TestHashPartitioner, ShardRoutingCustomTest,
AnalysisAfterCoreReloadTest, DirectSolrConnectionTest,
TestFileDictionaryLookup, TestSolrConfigHandler, TestJsonRequest,
UUIDUpdateProcessorFallbackTest, TestInitParams, TestReRankQParserPlugin,
CollectionsAPIAsyncDistributedZkTest, SpellingQueryConverterTest,
TestAnalyzeInfixSuggestions, TestExceedMaxTermLength, ScriptEngineTest,
HLLUtilTest, TestSimpleTrackingShardHandler,
StatelessScriptUpdateProcessorFactoryTest, TestDefaultStatsCache,
FieldMutatingUpdateProcessorTest, SmileWriterTest, DataDrivenBlockJoinTest,
JsonLoaderTest, TestAddFieldRealTimeGet, SpellCheckComponentTest,
TestDocBasedVersionConstraints, ConcurrentDeleteAndCreateCollectionTest,
AsyncCallRequestStatusResponseTest, HdfsThreadLeakTest,
HdfsUnloadDistributedZkTest, FacetPivotSmallTest, UpdateParamsTest,
TestSortByMinMaxFunction, AssignTest, DistributedFacetPivotLongTailTest,
TestAuthenticationFramework, CacheHeaderTest, CachingDirectoryFactoryTest,
TestCoreDiscovery, TestRecoveryHdfs, HdfsChaosMonkeySafeLeaderTest,
DeleteShardTest, ConvertedLegacyTest, TestPivotHelperCode,
TestFoldingMultitermQuery, ClusterStateUpdateTest, ChaosMonkeySafeLeaderTest,
UnloadDistributedZkTest, CollectionsAPIDistributedZkTest, ZkSolrClientTest,
DistributedSpellCheckComponentTest, TestStressReorder]
[junit4] Completed [257/540] on J1 in 2.40s, 1 test, 1 error <<< FAILURES!
[...truncated 864 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:716: The following
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:660: The following
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:59: The following
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:230: The
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:514: The
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1429:
The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:984:
There were test failures: 540 suites, 2127 tests, 1 error, 68 ignored (32
assumptions)
Total time: 46 minutes 55 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
