Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/1925/
Java: 32bit/jdk1.8.0_162 -client -XX:+UseConcMarkSweepGC
2 tests failed.
FAILED: org.apache.solr.cloud.autoscaling.SearchRateTriggerTest.testTrigger
Error Message:
expected:<1> but was:<2>
Stack Trace:
java.lang.AssertionError: expected:<1> but was:<2>
at
__randomizedtesting.SeedInfo.seed([95DBDD57FD408A63:F610EBD5648FF94E]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at
org.apache.solr.cloud.autoscaling.SearchRateTriggerTest.testTrigger(SearchRateTriggerTest.java:133)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED: org.apache.solr.search.TestRealTimeGet.testStressGetRealtime
Error Message:
Captured an uncaught exception in thread: Thread[id=18363, name=WRITER9,
state=RUNNABLE, group=TGRP-TestRealTimeGet]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught
exception in thread: Thread[id=18363, name=WRITER9, state=RUNNABLE,
group=TGRP-TestRealTimeGet]
at
__randomizedtesting.SeedInfo.seed([95DBDD57FD408A63:FD5D735DB33E9C1]:0)
Caused by: java.lang.RuntimeException: org.apache.solr.common.SolrException:
Exception writing document id 74 to the index; possible analysis error.
at __randomizedtesting.SeedInfo.seed([95DBDD57FD408A63]:0)
at
org.apache.solr.search.TestRealTimeGet$1.run(TestRealTimeGet.java:706)
Caused by: org.apache.solr.common.SolrException: Exception writing document id
74 to the index; possible analysis error.
at
org.apache.solr.update.DirectUpdateHandler2.addDoc(DirectUpdateHandler2.java:246)
at
org.apache.solr.update.processor.RunUpdateProcessor.processAdd(RunUpdateProcessorFactory.java:67)
at
org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:55)
at
org.apache.solr.update.processor.DistributedUpdateProcessor.doLocalAdd(DistributedUpdateProcessor.java:950)
at
org.apache.solr.update.processor.DistributedUpdateProcessor.versionAdd(DistributedUpdateProcessor.java:1163)
at
org.apache.solr.update.processor.DistributedUpdateProcessor.processAdd(DistributedUpdateProcessor.java:633)
at
org.apache.solr.update.processor.LogUpdateProcessorFactory$LogUpdateProcessor.processAdd(LogUpdateProcessorFactory.java:103)
at
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.handleAdds(JsonLoader.java:501)
at
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.processUpdate(JsonLoader.java:145)
at
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.load(JsonLoader.java:121)
at org.apache.solr.handler.loader.JsonLoader.load(JsonLoader.java:84)
at
org.apache.solr.handler.UpdateRequestHandler$1.load(UpdateRequestHandler.java:97)
at
org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:68)
at
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:199)
at org.apache.solr.core.SolrCore.execute(SolrCore.java:2510)
at
org.apache.solr.servlet.DirectSolrConnection.request(DirectSolrConnection.java:125)
at org.apache.solr.SolrTestCaseJ4.updateJ(SolrTestCaseJ4.java:1286)
at
org.apache.solr.SolrTestCaseJ4.addAndGetVersion(SolrTestCaseJ4.java:1451)
at
org.apache.solr.search.TestRealTimeGet$1.run(TestRealTimeGet.java:675)
Caused by: java.lang.NullPointerException
at
org.apache.solr.update.UpdateLog.getCurrentLogSizeFromStream(UpdateLog.java:299)
at
org.apache.solr.update.DirectUpdateHandler2.getCurrentTLogSize(DirectUpdateHandler2.java:1007)
at
org.apache.solr.update.DirectUpdateHandler2.addDoc0(DirectUpdateHandler2.java:291)
at
org.apache.solr.update.DirectUpdateHandler2.addDoc(DirectUpdateHandler2.java:234)
... 18 more
Build Log:
[...truncated 13884 lines...]
[junit4] Suite: org.apache.solr.search.TestRealTimeGet
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.TestRealTimeGet_95DBDD57FD408A63-001/init-core-data-001
[junit4] 2> 1609646 WARN
(SUITE-TestRealTimeGet-seed#[95DBDD57FD408A63]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=23 numCloses=23
[junit4] 2> 1609646 INFO
(SUITE-TestRealTimeGet-seed#[95DBDD57FD408A63]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 1609647 INFO
(SUITE-TestRealTimeGet-seed#[95DBDD57FD408A63]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 1609648 INFO
(SUITE-TestRealTimeGet-seed#[95DBDD57FD408A63]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1609648 INFO
(SUITE-TestRealTimeGet-seed#[95DBDD57FD408A63]-worker) [ ]
o.a.s.SolrTestCaseJ4 updateLog impl=solr.CdcrUpdateLog
[junit4] 2> 1609649 INFO
(SUITE-TestRealTimeGet-seed#[95DBDD57FD408A63]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 1609649 INFO
(SUITE-TestRealTimeGet-seed#[95DBDD57FD408A63]-worker) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1609670 INFO
(SUITE-TestRealTimeGet-seed#[95DBDD57FD408A63]-worker) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
[junit4] 2> 1609681 INFO
(SUITE-TestRealTimeGet-seed#[95DBDD57FD408A63]-worker) [ ]
o.a.s.s.IndexSchema [null] Schema name=example
[junit4] 2> 1609736 INFO
(SUITE-TestRealTimeGet-seed#[95DBDD57FD408A63]-worker) [ ]
o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid field id
[junit4] 2> 1609776 INFO
(SUITE-TestRealTimeGet-seed#[95DBDD57FD408A63]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1eb2358
[junit4] 2> 1609786 INFO
(SUITE-TestRealTimeGet-seed#[95DBDD57FD408A63]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1eb2358
[junit4] 2> 1609786 INFO
(SUITE-TestRealTimeGet-seed#[95DBDD57FD408A63]-worker) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1eb2358
[junit4] 2> 1609788 INFO (coreLoadExecutor-6518-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 1609789 INFO (coreLoadExecutor-6518-thread-1) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1609816 INFO (coreLoadExecutor-6518-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
[junit4] 2> 1609829 INFO (coreLoadExecutor-6518-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=example
[junit4] 2> 1609884 INFO (coreLoadExecutor-6518-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid
field id
[junit4] 2> 1609890 INFO (coreLoadExecutor-6518-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 1609891 INFO (coreLoadExecutor-6518-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.collection1' (registry 'solr.core.collection1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1eb2358
[junit4] 2> 1609891 INFO (coreLoadExecutor-6518-thread-1) [
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1609891 INFO (coreLoadExecutor-6518-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.TestRealTimeGet_95DBDD57FD408A63-001/init-core-data-001/]
[junit4] 2> 1609893 INFO (coreLoadExecutor-6518-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=24, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.8578497822447447]
[junit4] 2> 1609896 WARN (coreLoadExecutor-6518-thread-1) [
x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler
{type = requestHandler,name = /dump,class = DumpRequestHandler,attributes =
{initParams=a, name=/dump, class=DumpRequestHandler},args =
{defaults={a=A,b=B}}}
[junit4] 2> 1609932 INFO (coreLoadExecutor-6518-thread-1) [
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.CdcrUpdateLog
[junit4] 2> 1609932 INFO (coreLoadExecutor-6518-thread-1) [
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 1609932 INFO (coreLoadExecutor-6518-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1609933 INFO (coreLoadExecutor-6518-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1609933 INFO (coreLoadExecutor-6518-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=41, maxMergeAtOnceExplicit=29, maxMergedSegmentMB=70.6650390625,
floorSegmentMB=1.87890625, forceMergeDeletesPctAllowed=22.517563974905855,
segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 1609934 INFO (coreLoadExecutor-6518-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@cacbb2[collection1]
main]
[junit4] 2> 1609934 WARN (coreLoadExecutor-6518-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf;
switching to use InMemory storage instead.
[junit4] 2> 1609935 INFO (coreLoadExecutor-6518-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1609936 INFO
(searcherExecutor-6519-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@cacbb2[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1609936 INFO (coreLoadExecutor-6518-thread-1) [
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1600799075872014336
[junit4] 2> 1609938 INFO
(SUITE-TestRealTimeGet-seed#[95DBDD57FD408A63]-worker) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 1609941 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testVersions
[junit4] 2> 1609941 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1609942 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1dda32e[collection1] realtime]
[junit4] 2> 1609942 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*
(-9223372036854775807)} 0 0
[junit4] 2> 1609942 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1600799075878305792,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1609942 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@bf9952
commitCommandVersion:1600799075878305792
[junit4] 2> 1609943 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@105392a[collection1] main]
[junit4] 2> 1609943 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1609946 INFO (searcherExecutor-6519-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@105392a[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1609946 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{commit=} 0 3
[junit4] 2> 1609950 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[1 (1600799075885645824)]} 0 1
[junit4] 2> 1609951 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:1&wt=xml}
hits=0 status=0 QTime=0
[junit4] 2> 1609951 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&id=1&wt=xml} status=0 QTime=0
[junit4] 2> 1609951 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1600799075887742976,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1609951 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@bf9952
commitCommandVersion:1600799075887742976
[junit4] 2> 1609954 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@ee769b[collection1] main]
[junit4] 2> 1609954 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1609956 INFO (searcherExecutor-6519-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@ee769b[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.4.0):C1)))}
[junit4] 2> 1609956 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{commit=} 0 4
[junit4] 2> 1609957 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&id=1&wt=xml} status=0 QTime=0
[junit4] 2> 1609958 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[1
(1600799075885645834)]} 0 0
[junit4] 2> 1609958 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&id=1&wt=xml} status=0 QTime=0
[junit4] 2> 1609958 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[1
(1600799075885645833)]} 0 0
[junit4] 2> 1609958 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&id=1&wt=xml} status=0 QTime=0
[junit4] 2> 1609958 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={update.distrib=FROMLEADER&_version_=1600799075885645833&wt=json&indent=true}{delete=[1
(-1600799075885645833)]} 0 0
[junit4] 2> 1609959 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&id=1&wt=xml} status=0 QTime=0
[junit4] 2> 1609959 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1600799075896131584,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1609959 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@bf9952
commitCommandVersion:1600799075896131584
[junit4] 2> 1609960 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1666191[collection1] main]
[junit4] 2> 1609961 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1609962 INFO (searcherExecutor-6519-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@1666191[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.4.0):C1)))}
[junit4] 2> 1609963 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{commit=} 0 3
[junit4] 2> 1609963 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[1
(1600799075885645833)]} 0 0
[junit4] 2> 1609963 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&id=1&wt=xml} status=0 QTime=0
[junit4] 2> 1609964 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={update.distrib=FROMLEADER&_version_=1600799075885645833&wt=json&indent=true}{delete=[1
(-1600799075885645833)]} 0 0
[junit4] 2> 1609964 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&id=1&wt=xml} status=0 QTime=0
[junit4] 2> 1609964 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={update.distrib=FROMLEADER&_version_=1600799075885645839&wt=json&indent=true}{delete=[1
(-1600799075885645839)]} 0 0
[junit4] 2> 1609965 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[1
(1600799075885645838)]} 0 0
[junit4] 2> 1609965 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&id=1&wt=xml} status=0 QTime=0
[junit4] 2> 1609965 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1600799075902423040,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1609965 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@bf9952
commitCommandVersion:1600799075902423040
[junit4] 2> 1609965 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@b5e81d[collection1] main]
[junit4] 2> 1609966 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1609967 INFO (searcherExecutor-6519-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@b5e81d[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1609967 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{commit=} 0 2
[junit4] 2> 1609969 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{deleteByQuery=id:2
(-1600799075905568768)} 0 1
[junit4] 2> 1609969 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&id=1&wt=xml} status=0 QTime=0
[junit4] 2> 1609969 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[2 (1600799075906617344)]} 0 0
[junit4] 2> 1609971 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1ac0e5e[collection1] realtime]
[junit4] 2> 1609972 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@af13ad[collection1] realtime]
[junit4] 2> 1609972 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{deleteByQuery=id:2
(-1600799075907665920)} 0 2
[junit4] 2> 1609972 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&id=2&wt=xml} status=0 QTime=0
[junit4] 2> 1609973 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[3
(1600799075907667020)]} 0 0
[junit4] 2> 1609973 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[4
(1600799075907667120)]} 0 0
[junit4] 2> 1609975 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@ef0085[collection1] realtime]
[junit4] 2> 1609976 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1b228a7[collection1] realtime]
[junit4] 2> 1609976 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={update.distrib=FROMLEADER&_version_=-1600799075907667070&versions=true&wt=json&indent=true}{deleteByQuery=id:(3
4 5 6) (-1600799075907667070)} 0 2
[junit4] 2> 1609976 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&id=3&wt=xml} status=0 QTime=0
[junit4] 2> 1609976 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&fl=id&id=4&wt=xml} status=0 QTime=0
[junit4] 2> 1609977 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[5
(1600799075907667121)]} 0 0
[junit4] 2> 1609977 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.DirectUpdateHandler2 Reordered DBQs detected.
Update=add{_version_=1600799075907667021,id=6}
DBQs=[DBQ{version=1600799075907667070,q=id:(3 4 5 6)}]
[junit4] 2> 1609979 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@e104a2[collection1] realtime]
[junit4] 2> 1609979 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[6
(1600799075907667021)]} 0 2
[junit4] 2> 1609980 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&fl=id&id=5&wt=xml} status=0 QTime=0
[junit4] 2> 1609980 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&id=6&wt=xml} status=0 QTime=0
[junit4] 2> 1609980 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1600799075918151680,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1609980 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@bf9952
commitCommandVersion:1600799075918151680
[junit4] 2> 1609980 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@cfcafa[collection1] main]
[junit4] 2> 1609981 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1609982 INFO (searcherExecutor-6519-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@cfcafa[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(7.4.0):C2/1:delGen=1)
Uninverting(_4(7.4.0):C2/1:delGen=1)))}
[junit4] 2> 1609983 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{commit=} 0 2
[junit4] 2> 1609984 INFO
(TEST-TestRealTimeGet.testVersions-seed#[95DBDD57FD408A63]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testVersions
[junit4] 2> 1609986 INFO
(TEST-TestRealTimeGet.testOptimisticLocking-seed#[95DBDD57FD408A63]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testOptimisticLocking
[junit4] 2> 1609986 INFO
(TEST-TestRealTimeGet.testOptimisticLocking-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1609987 INFO
(TEST-TestRealTimeGet.testOptimisticLocking-seed#[95DBDD57FD408A63]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@9a2297[collection1] realtime]
[junit4] 2> 1609987 INFO
(TEST-TestRealTimeGet.testOptimisticLocking-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*
(-9223372036854775807)} 0 0
[junit4] 2> 1609987 INFO
(TEST-TestRealTimeGet.testOptimisticLocking-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1600799075925491712,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1609987 INFO
(TEST-TestRealTimeGet.testOptimisticLocking-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@bf9952
commitCommandVersion:1600799075925491712
[junit4] 2> 1609988 INFO
(TEST-TestRealTimeGet.testOptimisticLocking-seed#[95DBDD57FD408A63]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@123bb59[collection1] main]
[junit4] 2> 1609988 INFO
(TEST-TestRealTimeGet.testOptimisticLocking-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1609989 INFO (searcherExecutor-6519-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@123bb59[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1609990 INFO
(TEST-TestRealTimeGet.testOptimisticLocking-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{commit=} 0 2
[junit4] 2> 1609991 INFO
(TEST-TestRealTimeGet.testOptimisticLocking-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[1 (1600799075928637440)]} 0 0
[junit4] 2> 1609991 INFO
(TEST-TestRealTimeGet.testOptimisticLocking-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{} 0 0
[junit4] 2> 1609991 INFO
(TEST-TestRealTimeGet.testOptimisticLocking-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=1600799075928637439&versions=true&wt=json&indent=true}{} 0 0
[junit4] 2> 1609992 INFO
(TEST-TestRealTimeGet.testOptimisticLocking-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=-1600799075928637440&versions=true&wt=json&indent=true}{} 0 0
[junit4] 2> 1609992 INFO
(TEST-TestRealTimeGet.testOptimisticLocking-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=1600799075928637778&versions=true&wt=json&indent=true}{} 0 0
[junit4] 2> 1609992 INFO
(TEST-TestRealTimeGet.testOptimisticLocking-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=1600799075928637439&versions=true&wt=json&indent=true}{} 0 0
[junit4] 2> 1609992 INFO
(TEST-TestRealTimeGet.testOptimisticLocking-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=-1600799075928637440&versions=true&wt=json&indent=true}{} 0 0
[junit4] 2> 1609992 INFO
(TEST-TestRealTimeGet.testOptimisticLocking-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=1600799075928637586&versions=true&wt=json&indent=true}{} 0 0
[junit4] 2> 1609992 INFO
(TEST-TestRealTimeGet.testOptimisticLocking-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=1600799075928637440&versions=true&wt=json&indent=true}{} 0 0
[junit4] 2> 1609993 INFO
(TEST-TestRealTimeGet.testOptimisticLocking-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=-1&versions=true&wt=json&indent=true}{delete=[I_do_not_exist
(-1600799075930734592)]} 0 0
[junit4] 2> 1609993 INFO
(TEST-TestRealTimeGet.testOptimisticLocking-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[1 (1600799075931783168)]} 0 0
[junit4] 2> 1609993 INFO
(TEST-TestRealTimeGet.testOptimisticLocking-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=1600799075928637440&versions=true&wt=json&indent=true}{} 0 0
[junit4] 2> 1609993 INFO
(TEST-TestRealTimeGet.testOptimisticLocking-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=1600799075928637440&versions=true&wt=json&indent=true}{} 0 0
[junit4] 2> 1609993 INFO
(TEST-TestRealTimeGet.testOptimisticLocking-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=1600799075931783168&versions=true&wt=json&indent=true}{delete=[1
(-1600799075931783169)]} 0 0
[junit4] 2> 1609993 INFO
(TEST-TestRealTimeGet.testOptimisticLocking-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=1600799075931783168&versions=true&wt=json&indent=true}{} 0 0
[junit4] 2> 1609993 INFO
(TEST-TestRealTimeGet.testOptimisticLocking-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=1600799075931783168&versions=true&wt=json&indent=true}{} 0 0
[junit4] 2> 1609993 INFO
(TEST-TestRealTimeGet.testOptimisticLocking-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=-1600799075931783167&versions=true&wt=json&indent=true}{add=[1
(1600799075931783170)]} 0 0
[junit4] 2> 1609994 INFO
(TEST-TestRealTimeGet.testOptimisticLocking-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&id=1&wt=xml} status=0 QTime=0
[junit4] 2> 1609994 INFO
(TEST-TestRealTimeGet.testOptimisticLocking-seed#[95DBDD57FD408A63]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testOptimisticLocking
[junit4] 2> 1609997 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testGetRealtime
[junit4] 2> 1609997 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1609998 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1295f53[collection1] realtime]
[junit4] 2> 1609998 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*
(-9223372036854775807)} 0 0
[junit4] 2> 1609998 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1600799075937026048,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1609998 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@bf9952
commitCommandVersion:1600799075937026048
[junit4] 2> 1609999 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1efaf9e[collection1] main]
[junit4] 2> 1609999 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1610000 INFO (searcherExecutor-6519-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@1efaf9e[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1610000 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{commit=} 0 2
[junit4] 2> 1610003 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[1 (1600799075941220352)]} 0 2
[junit4] 2> 1610004 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:1&wt=xml}
hits=0 status=0 QTime=0
[junit4] 2> 1610004 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&fl=id,+a_f,a_fd,a_fdS+++a_fs,a_fds,a_fdsS,++a_d,a_dd,a_ddS,++a_ds,a_dds,a_ddsS,++a_i,a_id,a_idS+++a_is,a_ids,a_idsS,+++a_l,a_ld,a_ldS+++a_ls,a_lds,a_ldsS&id=1&wt=xml}
status=0 QTime=0
[junit4] 2> 1610005 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&fl=id&ids=1&wt=xml} status=0 QTime=0
[junit4] 2> 1610005 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1600799075944366080,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1610005 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@bf9952
commitCommandVersion:1600799075944366080
[junit4] 2> 1610013 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@2b7c0a[collection1] main]
[junit4] 2> 1610014 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1610015 INFO (searcherExecutor-6519-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@2b7c0a[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_6(7.4.0):C1)))}
[junit4] 2> 1610016 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{commit=} 0 10
[junit4] 2> 1610016 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:1&wt=xml}
hits=1 status=0 QTime=0
[junit4] 2> 1610017 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&fl=id,+a_f,a_fd,a_fdS+++a_fs,a_fds,a_fdsS,++a_d,a_dd,a_ddS,++a_ds,a_dds,a_ddsS,++a_i,a_id,a_idS+++a_is,a_ids,a_idsS,+++a_l,a_ld,a_ldS+++a_ls,a_lds,a_ldsS&id=1&wt=xml}
status=0 QTime=0
[junit4] 2> 1610018 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&fl=id&id=1&wt=xml} status=0 QTime=0
[junit4] 2> 1610018 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&fl=id&ids=1&wt=xml} status=0 QTime=0
[junit4] 2> 1610019 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{delete=[1 (-1600799075957997568)]} 0 0
[junit4] 2> 1610019 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:1&wt=xml}
hits=1 status=0 QTime=0
[junit4] 2> 1610020 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&id=1&wt=xml} status=0 QTime=0
[junit4] 2> 1610020 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&ids=1&wt=xml} status=0 QTime=0
[junit4] 2> 1610020 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[10 (1600799075960094720)]} 0 0
[junit4] 2> 1610021 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[11 (1600799075961143296)]} 0 0
[junit4] 2> 1610021 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&fl=id&id=10&wt=xml} status=0 QTime=0
[junit4] 2> 1610023 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@32ff98[collection1] realtime]
[junit4] 2> 1610024 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1e1964[collection1] realtime]
[junit4] 2> 1610024 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{deleteByQuery=id:10 foo_s:abcdef (-1600799075962191872)} 0 2
[junit4] 2> 1610025 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&id=10&wt=xml} status=0 QTime=0
[junit4] 2> 1610025 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&fl=id&id=11&wt=xml} status=0 QTime=0
[junit4] 2> 1610026 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[12 (1600799075965337600)]} 0 0
[junit4] 2> 1610026 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:12&wt=xml}
hits=0 status=0 QTime=0
[junit4] 2> 1610026 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&fl=id,val_ls&id=12&wt=xml} status=0 QTime=0
[junit4] 2> 1610027 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1600799075967434752,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1610027 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@bf9952
commitCommandVersion:1600799075967434752
[junit4] 2> 1610028 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@2f85f[collection1] main]
[junit4] 2> 1610029 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1610030 INFO (searcherExecutor-6519-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@2f85f[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_7(7.4.0):C2/1:delGen=1)
Uninverting(_8(7.4.0):C1)))}
[junit4] 2> 1610031 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{commit=} 0 4
[junit4] 2> 1610031 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&fl=id,val_ls&id=12&wt=xml} status=0 QTime=0
[junit4] 2> 1610032 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:12&wt=xml}
hits=1 status=0 QTime=0
[junit4] 2> 1610033 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[12 (1600799075972677632)]} 0 1
[junit4] 2> 1610034 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[13 (1600799075974774784)]} 0 0
[junit4] 2> 1610034 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&fl=id&id=11&fq=id:11&wt=xml} status=0 QTime=0
[junit4] 2> 1610036 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1efc3b8[collection1] realtime]
[junit4] 2> 1610036 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&fl=id&id=12&fq=id:11&wt=xml} status=0 QTime=1
[junit4] 2> 1610036 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&fl=id&id=12&fq=id:13&wt=xml} status=0 QTime=0
[junit4] 2> 1610037 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&fl=id&id=12&fq=id:12&wt=xml} status=0 QTime=0
[junit4] 2> 1610037 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[14 (1600799075977920512)]} 0 0
[junit4] 2> 1610038 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[15 (1600799075978969088)]} 0 0
[junit4] 2> 1610040 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@651c91[collection1] realtime]
[junit4] 2> 1610041 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&fl=id&ids=12,14,13,15&fq=id:[10+TO+14]&fq=id:[13+TO+19]&wt=xml}
status=0 QTime=2
[junit4] 2> 1610041 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[16 (1600799075982114816)]} 0 0
[junit4] 2> 1610042 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[17 (1600799075983163392)]} 0 0
[junit4] 2> 1610044 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1ac716a[collection1] realtime]
[junit4] 2> 1610045 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&fl=id&ids=17,16,15,14&fq=id:[15+TO+16]&wt=xml} status=0 QTime=2
[junit4] 2> 1610045 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&fl=id&ids=17,16,15,14&fq={!frange+l%3D15+u%3D16}id&wt=xml}
status=0 QTime=0
[junit4] 2> 1610046 INFO
(TEST-TestRealTimeGet.testGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testGetRealtime
[junit4] 2> 1610049 INFO
(TEST-TestRealTimeGet.testStressGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testStressGetRealtime
[junit4] 2> 1610049 INFO
(TEST-TestRealTimeGet.testStressGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1610049 INFO
(TEST-TestRealTimeGet.testStressGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@bf6f36[collection1] realtime]
[junit4] 2> 1610050 INFO
(TEST-TestRealTimeGet.testStressGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*
(-9223372036854775807)} 0 1
[junit4] 2> 1610050 INFO
(TEST-TestRealTimeGet.testStressGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1600799075991552000,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1610050 INFO
(TEST-TestRealTimeGet.testStressGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@bf9952
commitCommandVersion:1600799075991552000
[junit4] 2> 1610051 INFO
(TEST-TestRealTimeGet.testStressGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@55ad4c[collection1] main]
[junit4] 2> 1610051 INFO
(TEST-TestRealTimeGet.testStressGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1610052 INFO (searcherExecutor-6519-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@55ad4c[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1610053 INFO
(TEST-TestRealTimeGet.testStressGetRealtime-seed#[95DBDD57FD408A63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{commit=} 0 2
[junit4] 2> 1610057 INFO (WRITER9) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=1193577617&versions=true&wt=json&indent=true}{} 0 0
[junit4] 2> 1610057 INFO (WRITER7) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=913324772&versions=true&wt=json&indent=true}{} 0 0
[junit4] 2> 1610057 INFO (WRITER6) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=1927281345&versions=true&wt=json&indent=true}{} 0 0
[junit4] 2> 1610057 INFO (WRITER13) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=1591372899&versions=true&wt=json&indent=true}{} 0 0
[junit4] 2> 1610057 INFO (WRITER4) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=0&versions=true&wt=json&indent=true}{delete=[67
(-1600799075998892036)]} 0 0
[junit4] 2> 1610057 INFO (WRITER5) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{delete=[64 (-1600799075998892037)]}
0 0
[junit4] 2> 1610057 INFO (WRITER3) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{delete=[58 (-1600799075998892035)]}
0 0
[junit4] 2> 1610058 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=15} status=0 QTime=0
[junit4] 2> 1610057 INFO (WRITER0) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{delete=[8 (-1600799075998892032)]} 0 0
[junit4] 2> 1610058 INFO (WRITER11) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[55 (1600799075998892040)]} 0 1
[junit4] 2> 1610058 INFO (READER2) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=44} status=0 QTime=0
[junit4] 2> 1610058 INFO (READER6) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=15} status=0 QTime=0
[junit4] 2> 1610058 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=6} status=0 QTime=0
[junit4] 2> 1610059 INFO (READER2) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=61} status=0 QTime=0
[junit4] 2> 1610059 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=16} status=0 QTime=0
[junit4] 2> 1610059 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=64} status=0 QTime=0
[junit4] 2> 1610059 INFO (WRITER2) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=0&versions=true&wt=json&indent=true}{add=[5
(1600799075998892033)]} 0 2
[junit4] 2> 1610059 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:34&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610059 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:55&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610059 INFO (WRITER1) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[74 (1600799075998892034)]} 0 2
[junit4] 2> 1610059 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=63} status=0 QTime=0
[junit4] 2> 1610059 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=55} status=0 QTime=0
[junit4] 2> 1610059 INFO (WRITER10) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[37 (1600799075998892039)]} 0 2
[junit4] 2> 1610059 INFO (READER6) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:14&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610059 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=0} status=0 QTime=0
[junit4] 2> 1610059 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:55&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610059 INFO (READER6) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:34&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610059 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> 1610058 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:15&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610059 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=13} status=0 QTime=0
[junit4] 2> 1610059 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:66&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610059 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:55&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610059 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=55} status=0 QTime=0
[junit4] 2> 1610059 INFO (READER10) [ ] o.a.s.c.S.Request
[collection1] webapp=null path=null params={q=id:28&omitHeader=true&wt=json}
hits=0 status=0 QTime=0
[junit4] 2> 1610059 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:57&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610060 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:47&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610060 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:14&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610060 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:63&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610060 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:14&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610060 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:68&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610060 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:25&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610060 INFO (READER4) [ ] 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> 1610059 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=14} status=0 QTime=0
[junit4] 2> 1610065 INFO (WRITER12) [ ] o.a.s.s.SolrIndexSearcher
Opening [Searcher@173a7eb[collection1] realtime]
[junit4] 2> 1610065 INFO (READER2) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=27} status=0 QTime=6
[junit4] 2> 1610066 INFO (READER2) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:14&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610066 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=65} status=0 QTime=5
[junit4] 2> 1610066 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=31} status=0 QTime=6
[junit4] 2> 1610066 INFO (READER2) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=9} status=0 QTime=0
[junit4] 2> 1610066 INFO (WRITER12) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{deleteByQuery=id:29 (-1600799076000989185)} 0 8
[junit4] 2> 1610067 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=55} status=0 QTime=6
[junit4] 2> 1610067 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=45} status=0 QTime=7
[junit4] 2> 1610067 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:26&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610067 INFO (WRITER6) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=754373366&versions=true&wt=json&indent=true}{} 0 9
[junit4] 2> 1610067 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=14} status=0 QTime=0
[junit4] 2> 1610067 INFO (WRITER13) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[7 (1600799076009377792)]} 0 9
[junit4] 2> 1610067 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=14} status=0 QTime=0
[junit4] 2> 1610067 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:72&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610067 INFO (WRITER8) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=0&versions=true&wt=json&indent=true}{add=[18
(1600799075998892038)]} 0 10
[junit4] 2> 1610067 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=2} status=0 QTime=0
[junit4] 2> 1610067 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=14} status=0 QTime=7
[junit4] 2> 1610068 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=35} status=0 QTime=0
[junit4] 2> 1610068 INFO (WRITER16) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[51 (1600799076010426368)]} 0 10
[junit4] 2> 1610068 INFO (WRITER4) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[48 (1600799076010426369)]} 0 9
[junit4] 2> 1610068 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=14} status=0 QTime=0
[junit4] 2> 1610068 INFO (WRITER3) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=598215924&versions=true&wt=json&indent=true}{} 0 9
[junit4] 2> 1610066 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=71} status=0 QTime=5
[junit4] 2> 1610068 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=65} status=0 QTime=0
[junit4] 2> 1610068 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=63} status=0 QTime=0
[junit4] 2> 1610069 INFO (READER2) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=35} status=0 QTime=0
[junit4] 2> 1610069 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:79&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610068 INFO (READER6) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=79} status=0 QTime=8
[junit4] 2> 1610068 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=53} status=0 QTime=0
[junit4] 2> 1610069 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:20&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610069 INFO (WRITER5) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[52 (1600799076011474944)]} 0 10
[junit4] 2> 1610069 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:60&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610069 INFO (WRITER17) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=765034781&versions=true&wt=json&indent=true}{} 0 10
[junit4] 2> 1610068 INFO (WRITER9) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[32 (1600799076009377793)]} 0 10
[junit4] 2> 1610069 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=20} status=0 QTime=0
[junit4] 2> 1610069 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:13&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610069 INFO (WRITER2) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[73 (1600799076011474945)]} 0 10
[junit4] 2> 1610068 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=5} status=0 QTime=8
[junit4] 2> 1610069 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:29&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610069 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=42} status=0 QTime=0
[junit4] 2> 1610069 INFO (WRITER1) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[77 (1600799076011474946)]} 0 10
[junit4] 2> 1610069 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:42&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610069 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=48} status=0 QTime=0
[junit4] 2> 1610070 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:70&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610070 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:44&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610070 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=77} status=0 QTime=0
[junit4] 2> 1610070 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=22} status=0 QTime=0
[junit4] 2> 1610070 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:22&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610070 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:70&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610070 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=24} status=0 QTime=0
[junit4] 2> 1610070 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:53&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610070 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:62&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610070 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:77&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610070 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=26} status=0 QTime=0
[junit4] 2> 1610070 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=64} status=0 QTime=0
[junit4] 2> 1610071 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=26} status=0 QTime=0
[junit4] 2> 1610071 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:27&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610071 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=49} status=0 QTime=0
[junit4] 2> 1610071 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=10} status=0 QTime=0
[junit4] 2> 1610071 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=68} status=0 QTime=0
[junit4] 2> 1610071 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:17&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610071 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:43&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610071 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=47} status=0 QTime=0
[junit4] 2> 1610071 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:30&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610071 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=13} status=0 QTime=0
[junit4] 2> 1610072 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=77} status=0 QTime=0
[junit4] 2> 1610072 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:39&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610072 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:19&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610072 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=32} status=0 QTime=0
[junit4] 2> 1610072 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=67} status=0 QTime=0
[junit4] 2> 1610072 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=13} status=0 QTime=0
[junit4] 2> 1610072 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=60} status=0 QTime=0
[junit4] 2> 1610072 INFO (READER4) [ ] 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> 1610072 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:41&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610072 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:75&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610072 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=68} status=0 QTime=0
[junit4] 2> 1610072 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:19&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610073 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=60} status=0 QTime=0
[junit4] 2> 1610073 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:77&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610073 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=38} status=0 QTime=0
[junit4] 2> 1610073 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=9} status=0 QTime=0
[junit4] 2> 1610073 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=43} status=0 QTime=0
[junit4] 2> 1610073 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=25} status=0 QTime=0
[junit4] 2> 1610073 INFO (READER4) [ ] 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> 1610073 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:18&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610067 INFO (READER10) [ ] o.a.s.c.S.Request
[collection1] webapp=null path=null params={wt=json&qt=/get&ids=72} status=0
QTime=7
[junit4] 2> 1610073 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=17} status=0 QTime=0
[junit4] 2> 1610067 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=64} status=0 QTime=7
[junit4] 2> 1610067 INFO (WRITER14) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[72 (1600799076008329216)]} 0 9
[junit4] 2> 1610067 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=50} status=0 QTime=0
[junit4] 2> 1610067 INFO (WRITER7) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=0&versions=true&wt=json&indent=true}{add=[79
(1600799076008329217)]} 0 9
[junit4] 2> 1610073 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=15} status=0 QTime=0
[junit4] 2> 1610073 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:13&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610073 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:77&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610073 INFO (READER10) [ ] o.a.s.c.S.Request
[collection1] webapp=null path=null params={wt=json&qt=/get&ids=44} status=0
QTime=0
[junit4] 2> 1610074 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=72} status=0 QTime=0
[junit4] 2> 1610074 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=79} status=0 QTime=0
[junit4] 2> 1610074 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=79} status=0 QTime=0
[junit4] 2> 1610074 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=30} status=0 QTime=0
[junit4] 2> 1610074 INFO (READER10) [ ] o.a.s.c.S.Request
[collection1] webapp=null path=null params={wt=json&qt=/get&ids=16} status=0
QTime=0
[junit4] 2> 1610074 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=50} status=0 QTime=0
[junit4] 2> 1610074 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:51&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610074 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=79} status=0 QTime=0
[junit4] 2> 1610074 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=79} status=0 QTime=0
[junit4] 2> 1610074 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=19} status=0 QTime=0
[junit4] 2> 1610069 INFO (WRITER10) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=0&versions=true&wt=json&indent=true}{add=[14
(1600799076011474947)]} 0 10
[junit4] 2> 1610069 INFO (READER2) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=49} status=0 QTime=0
[junit4] 2> 1610074 INFO (READER10) [ ] o.a.s.c.S.Request
[collection1] webapp=null path=null params={q=id:59&omitHeader=true&wt=json}
hits=0 status=0 QTime=0
[junit4] 2> 1610069 INFO (WRITER0) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={_version_=0&versions=true&wt=json&indent=true}{add=[59
(1600799076010426370)]} 0 10
[junit4] 2> 1610074 INFO (READER7) [ ] 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> 1610074 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:42&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610074 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:79&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610074 INFO (READER10) [ ] o.a.s.c.S.Request
[collection1] webapp=null path=null params={q=id:79&omitHeader=true&wt=json}
hits=0 status=0 QTime=0
[junit4] 2> 1610074 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:48&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610074 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=13} status=0 QTime=0
[junit4] 2> 1610074 INFO (READER10) [ ] 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> 1610074 INFO (READER2) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=78} status=0 QTime=0
[junit4] 2> 1610075 INFO (READER6) [ ] 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> 1610075 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:44&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610074 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=13} status=0 QTime=0
[junit4] 2> 1610075 INFO (READER10) [ ] o.a.s.c.S.Request
[collection1] webapp=null path=null params={q=id:67&omitHeader=true&wt=json}
hits=0 status=0 QTime=0
[junit4] 2> 1610075 INFO (READER6) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:13&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610075 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:52&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610075 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=13} status=0 QTime=0
[junit4] 2> 1610075 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:45&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610074 INFO (READER8) [ ] 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> 1610074 INFO (READER1) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=59} status=0 QTime=0
[junit4] 2> 1610075 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:13&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610075 INFO (READER10) [ ] o.a.s.c.S.Request
[collection1] webapp=null path=null params={wt=json&qt=/get&ids=14} status=0
QTime=0
[junit4] 2> 1610075 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=13} status=0 QTime=0
[junit4] 2> 1610075 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=66} status=0 QTime=0
[junit4] 2> 1610075 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=69} status=0 QTime=0
[junit4] 2> 1610075 INFO (READER2) [ ] 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> 1610075 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:44&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610075 INFO (WRITER11) [ ] o.a.s.u.DirectUpdateHandler2
start
commit{_version_=1600799076000989184,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 1610075 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=27} status=0 QTime=0
[junit4] 2> 1610075 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=37} status=0 QTime=7
[junit4] 2> 1610075 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:70&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610075 INFO (READER10) [ ] o.a.s.c.S.Request
[collection1] webapp=null path=null params={wt=json&qt=/get&ids=13} status=0
QTime=0
[junit4] 2> 1610076 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=24} status=0 QTime=0
[junit4] 2> 1610076 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:31&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610076 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:45&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610076 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=47} status=0 QTime=0
[junit4] 2> 1610076 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=6} status=0 QTime=0
[junit4] 2> 1610076 INFO (READER7) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:52&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610076 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:58&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610076 INFO (READER5) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=61} status=0 QTime=0
[junit4] 2> 1610076 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=13} status=0 QTime=0
[junit4] 2> 1610076 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:4&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610075 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:42&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610077 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:13&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610077 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:53&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610077 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=75} status=0 QTime=0
[junit4] 2> 1610078 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=61} status=0 QTime=0
[junit4] 2> 1610078 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:66&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610078 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=13} status=0 QTime=0
[junit4] 2> 1610078 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=13} status=0 QTime=0
[junit4] 2> 1610078 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=0} status=0 QTime=0
[junit4] 2> 1610078 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=40} status=0 QTime=0
[junit4] 2> 1610078 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=46} status=0 QTime=0
[junit4] 2> 1610078 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=42} status=0 QTime=0
[junit4] 2> 1610078 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=32} status=0 QTime=0
[junit4] 2> 1610075 INFO (READER6) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=9} status=0 QTime=0
[junit4] 2> 1610078 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:59&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610079 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=18} status=0 QTime=1
[junit4] 2> 1610079 INFO (READER8) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:13&omitHeader=true&wt=json} hits=0 status=0
QTime=1
[junit4] 2> 1610079 INFO (READER2) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=8} status=0 QTime=2
[junit4] 2> 1610080 INFO (READER6) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:13&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610080 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:31&omitHeader=true&wt=json} hits=0 status=0
QTime=0
[junit4] 2> 1610080 INFO (READER3) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=62} status=0 QTime=0
[junit4] 2> 1610077 INFO (READER0) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=37} status=0 QTime=0
[junit4] 2> 1610080 INFO (READER8) [ ] 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> 1610080 INFO (READER4) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={wt=json&qt=/get&ids=67} status=0 QTime=0
[junit4] 2> 1610076 INFO (READER9) [ ] o.a.s.c.S.Request [collection1]
webapp=null path=null params={q=id:59&omitHeader=true&wt=json} hits=0 stat
[...truncated too long message...]
.1:36083_solr c:SearchRateTriggerTest-collection1 s:shard2 r:core_node8
x:SearchRateTriggerTest-collection1_shard2_replica_n6]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.collection.SearchRateTriggerTest-collection1.shard2.leader,
tag=19cd441
[junit4] 2> 2750304 INFO (coreCloseExecutor-5097-thread-1)
[n:127.0.0.1:39183_solr c:SearchRateTriggerTest-collection1 s:shard1
r:core_node3 x:SearchRateTriggerTest-collection1_shard1_replica_n1]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.collection.SearchRateTriggerTest-collection1.shard1.leader,
tag=edd8c5
[junit4] 2> 2750304 INFO (jetty-closer-5857-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=72182640427204619-127.0.0.1:34927_solr-n_0000000000) closing
[junit4] 2> 2750304 INFO
(OverseerStateUpdate-72182640427204619-127.0.0.1:34927_solr-n_0000000000) [
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:34927_solr
[junit4] 2> 2750310 WARN
(OverseerAutoScalingTriggerThread-72182640427204619-127.0.0.1:34927_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we
are closed, exiting.
[junit4] 2> 2750312 INFO (jetty-closer-5857-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@1ce3c6{/solr,null,UNAVAILABLE}
[junit4] 2> 2750313 INFO (jetty-closer-5857-thread-3) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2750313 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid
0x10071baa19d000d, likely client has closed socket
[junit4] 2> 2750314 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid
0x10071baa19d0010, likely client has closed socket
[junit4] 2> 2750314 INFO (zkCallback-5884-thread-2) [ ]
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:39183_solr
[junit4] 2> 2750314 INFO (jetty-closer-5857-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@17120bb{/solr,null,UNAVAILABLE}
[junit4] 2> 2750314 INFO (jetty-closer-5857-thread-1) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2750314 INFO (jetty-closer-5857-thread-4) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@93c139{/solr,null,UNAVAILABLE}
[junit4] 2> 2750314 INFO (jetty-closer-5857-thread-4) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2750315 ERROR
(SUITE-SearchRateTriggerTest-seed#[95DBDD57FD408A63]-worker) [ ]
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper
server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 2750315 INFO
(SUITE-SearchRateTriggerTest-seed#[95DBDD57FD408A63]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:37789 37789
[junit4] 2> 2751103 INFO (Thread-3041) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:37789 37789
[junit4] 2> 2751105 WARN (Thread-3041) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 12 /solr/aliases.json
[junit4] 2> 12
/solr/collections/SearchRateTriggerTest-collection1/terms/shard1
[junit4] 2> 12
/solr/collections/SearchRateTriggerTest-collection1/terms/shard2
[junit4] 2> 8 /solr/configs/conf
[junit4] 2> 8
/solr/collections/SearchRateTriggerTest-collection2/terms/shard2
[junit4] 2> 8
/solr/collections/SearchRateTriggerTest-collection2/terms/shard1
[junit4] 2> 4 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 12 /solr/clusterprops.json
[junit4] 2> 12 /solr/clusterstate.json
[junit4] 2> 8
/solr/collections/SearchRateTriggerTest-collection1/state.json
[junit4] 2> 4
/solr/collections/SearchRateTriggerTest-collection2/state.json
[junit4] 2> 2
/solr/overseer_elect/election/72182640427204619-127.0.0.1:34927_solr-n_0000000000
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 21 /solr/collections
[junit4] 2> 12 /solr/live_nodes
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.autoscaling.SearchRateTriggerTest_95DBDD57FD408A63-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70),
sim=RandomSimilarity(queryNorm=false): {}, locale=cs,
timezone=America/St_Vincent
[junit4] 2> NOTE: Linux 4.13.0-39-generic i386/Oracle Corporation
1.8.0_162 (32-bit)/cpus=8,threads=1,free=171765744,total=360767488
[junit4] 2> NOTE: All tests run in this JVM: [DataDrivenBlockJoinTest,
TestSuggestSpellingConverter, TestFaceting, SolrMetricReporterTest,
TestReloadDeadlock, TestSchemaVersionResource, TestSolrDeletionPolicy2,
TestComplexPhraseLeadingWildcard, TestJavabinTupleStreamParser,
HdfsUnloadDistributedZkTest, DateFieldTest, TestUtils,
RestartWhileUpdatingTest, BlobRepositoryCloudTest, TestFieldCacheReopen,
TestExactStatsCache, HdfsAutoAddReplicasIntegrationTest, TestFiltering,
SpellCheckComponentTest, TestShortCircuitedRequests, TestFieldResource,
TestApiFramework, SmileWriterTest, WrapperMergePolicyFactoryTest,
TestDefaultStatsCache, TestPrepRecovery, TestRequestForwarding,
LukeRequestHandlerTest, TestNonDefinedSimilarityFactory, ConvertedLegacyTest,
DocValuesTest, TestTolerantSearch, SuggestComponentContextFilterQueryTest,
TestCloudConsistency, TestNumericTokenStream,
TestStressCloudBlindAtomicUpdates, FileBasedSpellCheckerTest, CacheHeaderTest,
MetricUtilsTest, BufferStoreTest, TestNRTOpen, CoreAdminHandlerTest,
TestSQLHandler, DistributedFacetPivotWhiteBoxTest, CreateCollectionCleanupTest,
ConjunctionSolrSpellCheckerTest, TestLegacyFieldReuse,
TestBackupRepositoryFactory, TestNoOpRegenerator, SolrIndexMetricsTest,
DirectSolrSpellCheckerTest, BlockJoinFacetRandomTest,
DistributedFacetSimpleRefinementLongTailTest, TestLFUCache,
CoreAdminOperationTest, TestLMJelinekMercerSimilarityFactory,
TestCollationFieldDocValues, TestImplicitCoreProperties,
RegexBoostProcessorTest, TestUtilizeNode, HdfsSyncSliceTest,
CollectionPropsTest, MinimalSchemaTest, TestAtomicUpdateErrorCases,
TestObjectReleaseTracker, EnumFieldTest, MoreLikeThisHandlerTest,
LeaderElectionIntegrationTest, DistributedSuggestComponentTest,
AutoScalingHandlerTest, PeerSyncReplicationTest, TestCryptoKeys,
RecoveryZkTest, TestQueryTypes, TestExportWriter, TestConfigSetProperties,
BasicAuthStandaloneTest, TestCodecSupport, SearchHandlerTest,
TestJettySolrRunner, TestSimpleTextCodec, TestSolrFieldCacheBean,
TestDynamicFieldCollectionResource, SchemaApiFailureTest, CircularListTest,
MetricTriggerIntegrationTest, CollectionsAPIAsyncDistributedZkTest,
ResponseLogComponentTest, TestRandomDVFaceting, SpatialFilterTest,
TestManagedSchemaAPI, LeaderFailureAfterFreshStartTest,
NotRequiredUniqueKeyTest, DistanceFunctionTest, DistanceUnitsTest,
TestUseDocValuesAsStored, TestDFRSimilarityFactory, TestMacroExpander,
TestSimDistributedQueue, TestClusterStateProvider, TestBadConfig,
TestTestInjection, URLClassifyProcessorTest, TestChildDocTransformer,
MigrateRouteKeyTest, TestBulkSchemaConcurrent, SolrCloudExampleTest,
TestSmileRequest, TestStressReorder, TestRawTransformer,
HdfsChaosMonkeyNothingIsSafeTest, TestNumericTerms32, TestConfigReload,
DistributedFacetPivotLongTailTest, TestSolrCloudSnapshots,
SimpleMLTQParserTest, ClusterStateTest, TestSolrCoreProperties,
TestPayloadScoreQParserPlugin, NumericFieldsTest,
ClassificationUpdateProcessorFactoryTest, SaslZkACLProviderTest,
TestSortByMinMaxFunction, ResponseBuilderTest, HDFSCollectionsAPITest,
TestBlendedInfixSuggestions, CurrencyFieldTypeTest,
TestSubQueryTransformerDistrib, TestMaxScoreQueryParser,
BasicDistributedZkTest, TestRebalanceLeaders,
TestTolerantUpdateProcessorRandomCloud, ZkShardTermsTest, AssignTest,
CollectionReloadTest, CollectionTooManyReplicasTest,
TestCollectionsAPIViaSolrCloudCluster, TestReplicaProperties,
HttpTriggerListenerTest, NodeAddedTriggerTest, ScheduledTriggerIntegrationTest,
SearchRateTriggerTest]
[junit4] Completed [635/805 (2!)] on J2 in 42.06s, 3 tests, 1 failure <<<
FAILURES!
[...truncated 46834 lines...]
[repro] Jenkins log URL:
https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/1925/consoleText
[repro] Revision: fcae664e88110821647c1b28b0ad2c1d99ad3e13
[repro] Ant options: "-Dargs=-client -XX:+UseConcMarkSweepGC"
[repro] Repro line: ant test -Dtestcase=TestRealTimeGet
-Dtests.method=testStressGetRealtime -Dtests.seed=95DBDD57FD408A63
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=fi-FI
-Dtests.timezone=Africa/Tripoli -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[repro] Repro line: ant test -Dtestcase=SearchRateTriggerTest
-Dtests.method=testTrigger -Dtests.seed=95DBDD57FD408A63 -Dtests.multiplier=3
-Dtests.slow=true -Dtests.locale=cs -Dtests.timezone=America/St_Vincent
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
[repro] ant clean
[...truncated 6 lines...]
[repro] Test suites by module:
[repro] solr/core
[repro] TestRealTimeGet
[repro] SearchRateTriggerTest
[repro] ant compile-test
[...truncated 3316 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=10
-Dtests.class="*.TestRealTimeGet|*.SearchRateTriggerTest"
-Dtests.showOutput=onerror "-Dargs=-client -XX:+UseConcMarkSweepGC"
-Dtests.seed=95DBDD57FD408A63 -Dtests.multiplier=3 -Dtests.slow=true
-Dtests.locale=fi-FI -Dtests.timezone=Africa/Tripoli -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[...truncated 117 lines...]
[repro] Failures:
[repro] 0/5 failed: org.apache.solr.cloud.autoscaling.SearchRateTriggerTest
[repro] 0/5 failed: org.apache.solr.search.TestRealTimeGet
[repro] Exiting with code 0
[...truncated 40 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
