Build: https://builds.apache.org/job/Lucene-Solr-Tests-7.x/1144/
2 tests failed.
FAILED: org.apache.solr.search.TestRecovery.testExistOldBufferLog
Error Message:
Test abandoned because suite timeout was reached.
Stack Trace:
java.lang.Exception: Test abandoned because suite timeout was reached.
at __randomizedtesting.SeedInfo.seed([7388D8029F73B54C]:0)
FAILED: junit.framework.TestSuite.org.apache.solr.search.TestRecovery
Error Message:
Suite timeout exceeded (>= 7200000 msec).
Stack Trace:
java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
at __randomizedtesting.SeedInfo.seed([7388D8029F73B54C]:0)
Build Log:
[...truncated 15735 lines...]
[junit4] Suite: org.apache.solr.search.TestRecovery
[junit4] 2> Creating dataDir:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.search.TestRecovery_7388D8029F73B54C-001/init-core-data-001
[junit4] 2> 1645228 WARN
(SUITE-TestRecovery-seed#[7388D8029F73B54C]-worker) [ ] o.a.s.SolrTestCaseJ4
startTrackingSearchers: numOpens=21 numCloses=21
[junit4] 2> 1645230 INFO
(SUITE-TestRecovery-seed#[7388D8029F73B54C]-worker) [ ] o.a.s.SolrTestCaseJ4
Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 1645322 INFO
(SUITE-TestRecovery-seed#[7388D8029F73B54C]-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> 1645323 INFO
(SUITE-TestRecovery-seed#[7388D8029F73B54C]-worker) [ ] o.a.s.SolrTestCaseJ4
SecureRandom sanity checks: test.solr.allowed.securerandom=null &
java.security.egd=file:/dev/./urandom
[junit4] 2> 1645685 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.SolrTestCaseJ4 ###Starting
testLogReplayWithReorderedDBQInsertingChildnodes
[junit4] 2> 1645685 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.SolrTestCaseJ4 updateLog impl=solr.CdcrUpdateLog
[junit4] 2> 1645685 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 1645686 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from
paths:
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1646102 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.7.0
[junit4] 2> 1646211 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 1647211 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 1648818 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 1648818 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics
history in memory.
[junit4] 2> 1648899 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7ff8a4ce
[junit4] 2> 1648935 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7ff8a4ce
[junit4] 2> 1648936 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7ff8a4ce
[junit4] 2> 1649023 INFO (coreLoadExecutor-4421-thread-1) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1649417 INFO (coreLoadExecutor-4421-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.7.0
[junit4] 2> 1649510 INFO (coreLoadExecutor-4421-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1650212 INFO (coreLoadExecutor-4421-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 1650305 INFO (coreLoadExecutor-4421-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 1650305 INFO (coreLoadExecutor-4421-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@7ff8a4ce
[junit4] 2> 1650305 INFO (coreLoadExecutor-4421-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.search.TestRecovery_7388D8029F73B54C-001/init-core-data-001/]
[junit4] 2> 1650340 INFO (coreLoadExecutor-4421-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=22, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 1650450 WARN (coreLoadExecutor-4421-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> 1651171 INFO (coreLoadExecutor-4421-thread-1) [
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.CdcrUpdateLog
[junit4] 2> 1651171 INFO (coreLoadExecutor-4421-thread-1) [
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 1651173 INFO (coreLoadExecutor-4421-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1651173 INFO (coreLoadExecutor-4421-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1651209 INFO (coreLoadExecutor-4421-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=1377317811,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 1651239 INFO (coreLoadExecutor-4421-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@6581af6a[collection1] main]
[junit4] 2> 1651239 WARN (coreLoadExecutor-4421-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/conf;
switching to use InMemory storage instead.
[junit4] 2> 1651240 INFO (coreLoadExecutor-4421-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1651240 INFO (coreLoadExecutor-4421-thread-1) [
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1620397392150921216
[junit4] 2> 1651244 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 1651244 INFO
(searcherExecutor-4422-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@6581af6a[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1651246 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM
INDEX
[junit4] 2> 1651264 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@4bbf3163[collection1]
realtime]
[junit4] 2> 1651265 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] 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 19
[junit4] 2> 1651265 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1620397392177135616,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1651265 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@754a389f
commitCommandVersion:1620397392177135616
[junit4] 2> 1651337 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@641272e0[collection1] main]
[junit4] 2> 1651337 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1651339 INFO (searcherExecutor-4422-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@641272e0[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1651339 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{commit=} 0 74
[junit4] 2> 1651409 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null
params={update.distrib=FROMLEADER&_version_=-1&wt=json&indent=true}{deleteByQuery=id:RDBQ4_2
(-1)} 0 54
[junit4] 2> 1651447 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[RDBQ4_1]}
0 37
[junit4] 2> 1651447 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 1651447 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1455052062
[junit4] 2> 1651478 INFO (coreCloseExecutor-4427-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@7bb27705
[junit4] 2> 1651478 INFO (coreCloseExecutor-4427-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=7bb27705
[junit4] 2> 1651478 INFO (coreCloseExecutor-4427-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@241c4bf5: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@21a8e5c8
[junit4] 2> 1651603 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.node, tag=null
[junit4] 2> 1651603 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@4d24ffff: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@7811211c
[junit4] 2> 1651640 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jvm, tag=null
[junit4] 2> 1651640 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@bb9795: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@43086e28
[junit4] 2> 1651643 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jetty, tag=null
[junit4] 2> 1651643 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@5baef4e9: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@4ea2cb0b
[junit4] 2> 1651713 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from
paths:
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1652240 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.7.0
[junit4] 2> 1652316 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 1653541 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 1655172 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 1655172 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics
history in memory.
[junit4] 2> 1655244 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7ff8a4ce
[junit4] 2> 1655280 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7ff8a4ce
[junit4] 2> 1655280 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7ff8a4ce
[junit4] 2> 1655299 INFO (coreLoadExecutor-4437-thread-1) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1655492 INFO (coreLoadExecutor-4437-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.7.0
[junit4] 2> 1655580 INFO (coreLoadExecutor-4437-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1656143 INFO (coreLoadExecutor-4437-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 1656269 INFO (coreLoadExecutor-4437-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 1656269 INFO (coreLoadExecutor-4437-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@7ff8a4ce
[junit4] 2> 1656270 INFO (coreLoadExecutor-4437-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.search.TestRecovery_7388D8029F73B54C-001/init-core-data-001/]
[junit4] 2> 1656361 WARN (coreLoadExecutor-4437-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> 1656932 INFO (coreLoadExecutor-4437-thread-1) [
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.CdcrUpdateLog
[junit4] 2> 1656932 INFO (coreLoadExecutor-4437-thread-1) [
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 1656935 INFO (coreLoadExecutor-4437-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1656935 INFO (coreLoadExecutor-4437-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1656969 INFO (coreLoadExecutor-4437-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=22, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 1656970 INFO (coreLoadExecutor-4437-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@ad661c1[collection1]
main]
[junit4] 2> 1656970 WARN (coreLoadExecutor-4437-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/conf;
switching to use InMemory storage instead.
[junit4] 2> 1656971 INFO (coreLoadExecutor-4437-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1657062 INFO
(searcherExecutor-4438-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@ad661c1[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1657123 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 1657130 WARN
(recoveryExecutor-4440-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.UpdateLog Starting log replay
tlog{file=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.search.TestRecovery_7388D8029F73B54C-001/init-core-data-001/tlog/tlog.0000000000000000001.1
refcount=1} active=false starting pos=0 inSortedOrder=false
[junit4] 2> 1657438 INFO
(recoveryExecutor-4440-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 start
commit{flags=2,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1657438 INFO
(recoveryExecutor-4440-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@1bbb09a2 commitCommandVersion:0
[junit4] 2> 1657656 INFO
(recoveryExecutor-4440-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1ad818b[collection1] main]
[junit4] 2> 1657656 INFO
(recoveryExecutor-4440-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1657662 INFO
(searcherExecutor-4438-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@1ad818b[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.7.0):c4:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=1.8.0_191,
java.vm.version=25.191-b12, lucene.version=7.7.0, os.arch=amd64,
java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-112-generic,
timestamp=1545331381466}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 1657663 INFO
(recoveryExecutor-4440-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {deleteByQuery=id:RDBQ4_2
(-1),add=[RDBQ4_1]} 0 532
[junit4] 2> 1657663 WARN
(recoveryExecutor-4440-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.UpdateLog Log replay finished. recoveryInfo=RecoveryInfo{adds=1
deletes=0 deleteByQuery=1 errors=0 positionOfStart=0}
[junit4] 2> 1657677 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&wt=xml} hits=4 status=0 QTime=0
[junit4] 2> 1657685 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 1657685 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1343920529
[junit4] 2> 1657778 INFO (coreCloseExecutor-4443-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@7bc9cd25
[junit4] 2> 1657778 INFO (coreCloseExecutor-4443-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=7bc9cd25
[junit4] 2> 1657778 INFO (coreCloseExecutor-4443-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@3f7f724f: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@e0c96ad
[junit4] 2> 1657948 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.node, tag=null
[junit4] 2> 1657948 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@465f02a3: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@c718565
[junit4] 2> 1657986 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jvm, tag=null
[junit4] 2> 1657986 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@6b20f918: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@43086e28
[junit4] 2> 1657988 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jetty, tag=null
[junit4] 2> 1658005 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@f2b1dd7: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@4ea2cb0b
[junit4] 2> 1658088 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQInsertingChildnodes-seed#[7388D8029F73B54C])
[ ] o.a.s.SolrTestCaseJ4 ###Ending
testLogReplayWithReorderedDBQInsertingChildnodes
[junit4] 2> 1658125 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.SolrTestCaseJ4 ###Starting
testLogReplayWithReorderedDBQByAsterixAndChildDocs
[junit4] 2> 1658125 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.SolrTestCaseJ4 updateLog impl=solr.UpdateLog
[junit4] 2> 1658125 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 1658126 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from
paths:
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1658635 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.7.0
[junit4] 2> 1658745 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 1659495 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 1660558 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 1660558 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics
history in memory.
[junit4] 2> 1660650 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7ff8a4ce
[junit4] 2> 1660743 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7ff8a4ce
[junit4] 2> 1660743 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7ff8a4ce
[junit4] 2> 1660822 INFO (coreLoadExecutor-4453-thread-1) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1661063 INFO (coreLoadExecutor-4453-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.7.0
[junit4] 2> 1661261 INFO (coreLoadExecutor-4453-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1661860 INFO (coreLoadExecutor-4453-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 1661882 INFO (coreLoadExecutor-4453-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 1661882 INFO (coreLoadExecutor-4453-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@7ff8a4ce
[junit4] 2> 1661883 INFO (coreLoadExecutor-4453-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.search.TestRecovery_7388D8029F73B54C-001/init-core-data-001/]
[junit4] 2> 1661898 INFO (coreLoadExecutor-4453-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=22, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 1661957 WARN (coreLoadExecutor-4453-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> 1662161 INFO (coreLoadExecutor-4453-thread-1) [
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1662161 INFO (coreLoadExecutor-4453-thread-1) [
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 1662163 INFO (coreLoadExecutor-4453-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1662163 INFO (coreLoadExecutor-4453-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1662164 INFO (coreLoadExecutor-4453-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=1377317811,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 1662165 INFO (coreLoadExecutor-4453-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@621f8d94[collection1] main]
[junit4] 2> 1662165 WARN (coreLoadExecutor-4453-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/conf;
switching to use InMemory storage instead.
[junit4] 2> 1662166 INFO (coreLoadExecutor-4453-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1662166 INFO (coreLoadExecutor-4453-thread-1) [
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1620397403607662592
[junit4] 2> 1662189 INFO
(searcherExecutor-4454-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@621f8d94[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1662200 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 1662201 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM
INDEX
[junit4] 2> 1662203 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@6856f082[collection1]
realtime]
[junit4] 2> 1662203 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] 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 2
[junit4] 2> 1662203 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1620397403646459904,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1662203 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@14457438
commitCommandVersion:1620397403646459904
[junit4] 2> 1662218 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@37bfcac6[collection1] main]
[junit4] 2> 1662234 INFO (searcherExecutor-4454-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@37bfcac6[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1662234 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1662234 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={}{commit=} 0 30
[junit4] 2> 1662268 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[RDBQ2_1
(2)]} 0 33
[junit4] 2> 1662269 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[RDBQ2_2
(5)]} 0 0
[junit4] 2> 1662321 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@311a9785[collection1]
realtime]
[junit4] 2> 1662322 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@2220c0e0[collection1]
realtime]
[junit4] 2> 1662323 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null
params={update.distrib=FROMLEADER&_version_=-4&wt=json&indent=true}{deleteByQuery=_root_:RDBQ2_1
_root_:RDBQ2_2 id:RDBQ2_3 _root_:RDBQ2_4 (-4)} 0 53
[junit4] 2> 1662323 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.u.DirectUpdateHandler2 Reordered DBQs detected.
Update=add{_version_=3,id=RDBQ2_3} DBQs=[DBQ{version=4,q=_root_:RDBQ2_1
_root_:RDBQ2_2 id:RDBQ2_3 _root_:RDBQ2_4}]
[junit4] 2> 1662362 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@268fcb07[collection1]
realtime]
[junit4] 2> 1662363 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[RDBQ2_3
(3)]} 0 39
[junit4] 2> 1662364 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null
path=null params={update.distrib=FROMLEADER&wt=json&indent=true}{add=[RDBQ2_4
(6)]} 0 0
[junit4] 2> 1662364 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 1662364 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1828675872
[junit4] 2> 1662450 INFO (coreCloseExecutor-4459-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@46d0eb83
[junit4] 2> 1662450 INFO (coreCloseExecutor-4459-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=46d0eb83
[junit4] 2> 1662451 INFO (coreCloseExecutor-4459-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@19c885b5: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@6e936cc4
[junit4] 2> 1662552 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.node, tag=null
[junit4] 2> 1662552 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@42c087c2: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@20e72690
[junit4] 2> 1662570 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jvm, tag=null
[junit4] 2> 1662570 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@505ea90a: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@43086e28
[junit4] 2> 1662605 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jetty, tag=null
[junit4] 2> 1662605 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@a4b9865: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@4ea2cb0b
[junit4] 2> 1662662 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from
paths:
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1662811 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.7.0
[junit4] 2> 1663104 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 1663534 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 1664424 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 1664424 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics
history in memory.
[junit4] 2> 1664500 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7ff8a4ce
[junit4] 2> 1664535 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7ff8a4ce
[junit4] 2> 1664535 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7ff8a4ce
[junit4] 2> 1664553 INFO (coreLoadExecutor-4469-thread-1) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1664736 INFO (coreLoadExecutor-4469-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.7.0
[junit4] 2> 1664791 INFO (coreLoadExecutor-4469-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1665367 INFO (coreLoadExecutor-4469-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 1665386 INFO (coreLoadExecutor-4469-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 1665386 INFO (coreLoadExecutor-4469-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@7ff8a4ce
[junit4] 2> 1665386 INFO (coreLoadExecutor-4469-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.search.TestRecovery_7388D8029F73B54C-001/init-core-data-001/]
[junit4] 2> 1665406 WARN (coreLoadExecutor-4469-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> 1665568 INFO (coreLoadExecutor-4469-thread-1) [
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1665568 INFO (coreLoadExecutor-4469-thread-1) [
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 1665588 INFO (coreLoadExecutor-4469-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1665588 INFO (coreLoadExecutor-4469-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1665589 INFO (coreLoadExecutor-4469-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=22, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 1665602 INFO (coreLoadExecutor-4469-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@742d8420[collection1] main]
[junit4] 2> 1665602 WARN (coreLoadExecutor-4469-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/conf;
switching to use InMemory storage instead.
[junit4] 2> 1665603 INFO (coreLoadExecutor-4469-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1665605 INFO
(searcherExecutor-4470-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@742d8420[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1665623 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 1665634 WARN
(recoveryExecutor-4472-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.UpdateLog Starting log replay
tlog{file=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.search.TestRecovery_7388D8029F73B54C-001/init-core-data-001/tlog/tlog.0000000000000000001
refcount=2} active=false starting pos=0 inSortedOrder=false
[junit4] 2> 1666142 INFO
(recoveryExecutor-4472-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@31923bf9[collection1] realtime]
[junit4] 2> 1666158 INFO
(recoveryExecutor-4472-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@369f8ba9[collection1] realtime]
[junit4] 2> 1666177 INFO
(replayUpdatesExecutor-4463-thread-1-processing-x:collection1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 Reordered DBQs detected.
Update=add{flags=a,_version_=3,id=RDBQ2_3} DBQs=[DBQ{version=4,q=_root_:RDBQ2_1
_root_:RDBQ2_2 id:RDBQ2_3 _root_:RDBQ2_4}]
[junit4] 2> 1666339 INFO
(replayUpdatesExecutor-4463-thread-1-processing-x:collection1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@4acaf278[collection1] realtime]
[junit4] 2> 1666412 INFO
(recoveryExecutor-4472-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 start
commit{flags=2,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1666412 INFO
(recoveryExecutor-4472-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@1fc8f243 commitCommandVersion:0
[junit4] 2> 1666655 INFO
(recoveryExecutor-4472-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@563f3038[collection1] main]
[junit4] 2> 1666690 INFO
(searcherExecutor-4470-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@563f3038[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.7.0):c6/3:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=1.8.0_191,
java.vm.version=25.191-b12, lucene.version=7.7.0, os.arch=amd64,
java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-112-generic,
timestamp=1545331390039}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]:delGen=1)
Uninverting(_3(7.7.0):c3:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12,
lucene.version=7.7.0, os.arch=amd64, java.runtime.version=1.8.0_191-b12,
source=flush, os.version=4.4.0-112-generic,
timestamp=1545331390440}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 1666690 INFO
(recoveryExecutor-4472-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1666690 INFO
(recoveryExecutor-4472-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[RDBQ2_1 (2), RDBQ2_2
(5), RDBQ2_3 (3), RDBQ2_4 (6)],deleteByQuery=_root_:RDBQ2_1 _root_:RDBQ2_2
id:RDBQ2_3 _root_:RDBQ2_4 (-4)} 0 1055
[junit4] 2> 1666690 WARN
(recoveryExecutor-4472-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.u.UpdateLog Log replay finished. recoveryInfo=RecoveryInfo{adds=4
deletes=0 deleteByQuery=1 errors=0 positionOfStart=0}
[junit4] 2> 1666690 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&wt=xml} hits=6 status=0 QTime=0
[junit4] 2> 1666788 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 1666788 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1236036238
[junit4] 2> 1666822 INFO (coreCloseExecutor-4475-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@1420c240
[junit4] 2> 1666822 INFO (coreCloseExecutor-4475-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=1420c240
[junit4] 2> 1666822 INFO (coreCloseExecutor-4475-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@3bbd33fb: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@66e4f93c
[junit4] 2> 1667105 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.node, tag=null
[junit4] 2> 1667106 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@52d4cff4: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@69d0631
[junit4] 2> 1667126 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jvm, tag=null
[junit4] 2> 1667126 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@37922599: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@43086e28
[junit4] 2> 1667129 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jetty, tag=null
[junit4] 2> 1667129 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@7388fc99: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@4ea2cb0b
[junit4] 2> 1667153 INFO
(TEST-TestRecovery.testLogReplayWithReorderedDBQByAsterixAndChildDocs-seed#[7388D8029F73B54C])
[ ] o.a.s.SolrTestCaseJ4 ###Ending
testLogReplayWithReorderedDBQByAsterixAndChildDocs
[junit4] 2> 1667168 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testRemoveOldLogs
[junit4] 2> 1667168 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.SolrTestCaseJ4 updateLog impl=solr.CdcrUpdateLog
[junit4] 2> 1667169 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 1667169 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1667423 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.7.0
[junit4] 2> 1667479 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 1668112 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 1669298 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 1669298 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history
in memory.
[junit4] 2> 1669551 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7ff8a4ce
[junit4] 2> 1669582 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7ff8a4ce
[junit4] 2> 1669582 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7ff8a4ce
[junit4] 2> 1669597 INFO (coreLoadExecutor-4485-thread-1) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1669816 INFO (coreLoadExecutor-4485-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.7.0
[junit4] 2> 1669855 INFO (coreLoadExecutor-4485-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1670271 INFO (coreLoadExecutor-4485-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 1670310 INFO (coreLoadExecutor-4485-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 1670343 INFO (coreLoadExecutor-4485-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@7ff8a4ce
[junit4] 2> 1670343 INFO (coreLoadExecutor-4485-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.search.TestRecovery_7388D8029F73B54C-001/init-core-data-001/]
[junit4] 2> 1670345 INFO (coreLoadExecutor-4485-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=22, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 1670454 WARN (coreLoadExecutor-4485-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> 1670845 INFO (coreLoadExecutor-4485-thread-1) [
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.CdcrUpdateLog
[junit4] 2> 1670845 INFO (coreLoadExecutor-4485-thread-1) [
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 1670847 INFO (coreLoadExecutor-4485-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1670847 INFO (coreLoadExecutor-4485-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1670848 INFO (coreLoadExecutor-4485-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=1377317811,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 1670882 INFO (coreLoadExecutor-4485-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@6567fb60[collection1] main]
[junit4] 2> 1670882 WARN (coreLoadExecutor-4485-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/conf;
switching to use InMemory storage instead.
[junit4] 2> 1670883 INFO (coreLoadExecutor-4485-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1670883 INFO (coreLoadExecutor-4485-thread-1) [
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1620397412748099584
[junit4] 2> 1670885 INFO
(searcherExecutor-4486-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@6567fb60[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1670903 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 1670904 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 1670907 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@3d34e136[collection1] realtime]
[junit4] 2> 1670908 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
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 4
[junit4] 2> 1670908 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1620397412774313984,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1670908 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@56b666c
commitCommandVersion:1620397412774313984
[junit4] 2> 1670991 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@68d89100[collection1] main]
[junit4] 2> 1670993 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1670994 INFO (searcherExecutor-4486-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@68d89100[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1670994 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{commit=} 0 86
[junit4] 2> 1671028 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=2090375453
[junit4] 2> 1671044 INFO (coreCloseExecutor-4491-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@5ee22cc2
[junit4] 2> 1671044 INFO (coreCloseExecutor-4491-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=5ee22cc2
[junit4] 2> 1671044 INFO (coreCloseExecutor-4491-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@41e5717c: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@3b688982
[junit4] 2> 1671137 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 1671137 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@223049a6: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@7bbb868b
[junit4] 2> 1671154 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 1671154 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@ce1d05d: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@43086e28
[junit4] 2> 1671156 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 1671156 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@37ac955d: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@4ea2cb0b
[junit4] 2> 1671194 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1671359 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.7.0
[junit4] 2> 1671468 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 1672104 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 1673710 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 1673710 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history
in memory.
[junit4] 2> 1673801 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7ff8a4ce
[junit4] 2> 1673894 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7ff8a4ce
[junit4] 2> 1673894 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7ff8a4ce
[junit4] 2> 1673909 INFO (coreLoadExecutor-4501-thread-1) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1674049 INFO (coreLoadExecutor-4501-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.7.0
[junit4] 2> 1674336 INFO (coreLoadExecutor-4501-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1674815 INFO (coreLoadExecutor-4501-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 1674866 INFO (coreLoadExecutor-4501-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 1674867 INFO (coreLoadExecutor-4501-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@7ff8a4ce
[junit4] 2> 1674867 INFO (coreLoadExecutor-4501-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.search.TestRecovery_7388D8029F73B54C-001/init-core-data-001/]
[junit4] 2> 1674886 WARN (coreLoadExecutor-4501-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> 1675237 INFO (coreLoadExecutor-4501-thread-1) [
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.CdcrUpdateLog
[junit4] 2> 1675237 INFO (coreLoadExecutor-4501-thread-1) [
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 1675239 INFO (coreLoadExecutor-4501-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1675239 INFO (coreLoadExecutor-4501-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1675241 INFO (coreLoadExecutor-4501-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=22, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 1675274 INFO (coreLoadExecutor-4501-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@39ccc2d3[collection1] main]
[junit4] 2> 1675275 WARN (coreLoadExecutor-4501-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/conf;
switching to use InMemory storage instead.
[junit4] 2> 1675275 INFO (coreLoadExecutor-4501-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1675275 INFO (coreLoadExecutor-4501-thread-1) [
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1620397417353445376
[junit4] 2> 1675333 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[3 (1620397417374416896)]} 0 37
[junit4] 2> 1675333 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[3 (1620397417414262784)]} 0 0
[junit4] 2> 1675333 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[3 (1620397417414262785)]} 0 0
[junit4] 2> 1675334 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
[junit4] 2> 1675334 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1620397417415311360,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1675367 INFO
(searcherExecutor-4502-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@39ccc2d3[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1675368 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@236ed664
commitCommandVersion:1620397417415311360
[junit4] 2> 1675665 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@7519d1de[collection1] main]
[junit4] 2> 1675665 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1675674 INFO (searcherExecutor-4502-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@7519d1de[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.7.0):c3/2:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=1.8.0_191,
java.vm.version=25.191-b12, lucene.version=7.7.0, os.arch=amd64,
java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-112-generic,
timestamp=1545331399396}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]:delGen=1)))}
[junit4] 2> 1675674 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{commit=} 0 339
[junit4] 2> 1675675 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
[junit4] 2> 1675688 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[6 (1620397417785458688)]} 0 1
[junit4] 2> 1675689 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[6 (1620397417786507264)]} 0 0
[junit4] 2> 1675689 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[6 (1620397417787555840)]} 0 0
[junit4] 2> 1675689 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
[junit4] 2> 1675689 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1620397417787555841,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1675689 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@236ed664
commitCommandVersion:1620397417787555841
[junit4] 2> 1675796 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@7bdd2f01[collection1] main]
[junit4] 2> 1675829 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1675855 INFO (searcherExecutor-4502-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@7bdd2f01[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.7.0):c3/2:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=1.8.0_191,
java.vm.version=25.191-b12, lucene.version=7.7.0, os.arch=amd64,
java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-112-generic,
timestamp=1545331399396}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]:delGen=1)
Uninverting(_1(7.7.0):c3/2:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12,
lucene.version=7.7.0, os.arch=amd64, java.runtime.version=1.8.0_191-b12,
source=flush, os.version=4.4.0-112-generic,
timestamp=1545331399730}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]:delGen=1)))}
[junit4] 2> 1675865 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{commit=} 0 175
[junit4] 2> 1675866 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
[junit4] 2> 1675867 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[9 (1620397417973153792)]} 0 1
[junit4] 2> 1675868 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[9 (1620397417975250944)]} 0 0
[junit4] 2> 1675868 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[9 (1620397417975250945)]} 0 0
[junit4] 2> 1675868 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
[junit4] 2> 1675868 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1620397417975250946,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1675868 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@236ed664
commitCommandVersion:1620397417975250946
[junit4] 2> 1676247 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@3d7bb166[collection1] main]
[junit4] 2> 1676249 INFO (searcherExecutor-4502-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@3d7bb166[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.7.0):c3/2:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=1.8.0_191,
java.vm.version=25.191-b12, lucene.version=7.7.0, os.arch=amd64,
java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-112-generic,
timestamp=1545331399396}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]:delGen=1)
Uninverting(_1(7.7.0):c3/2:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12,
lucene.version=7.7.0, os.arch=amd64, java.runtime.version=1.8.0_191-b12,
source=flush, os.version=4.4.0-112-generic,
timestamp=1545331399730}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]:delGen=1)
Uninverting(_2(7.7.0):c3/2:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12,
lucene.version=7.7.0, os.arch=amd64, java.runtime.version=1.8.0_191-b12,
source=flush, os.version=4.4.0-112-generic,
timestamp=1545331399928}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]:delGen=1)))}
[junit4] 2> 1676249 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1676249 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{commit=} 0 381
[junit4] 2> 1676268 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=18
[junit4] 2> 1676284 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[12 (1620397418410409984)]} 0 1
[junit4] 2> 1676284 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[12 (1620397418411458560)]} 0 0
[junit4] 2> 1676303 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[12 (1620397418431381504)]} 0 0
[junit4] 2> 1676303 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
[junit4] 2> 1676304 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1620397418432430080,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1676304 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@236ed664
commitCommandVersion:1620397418432430080
[junit4] 2> 1676451 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@57ef52c7[collection1] main]
[junit4] 2> 1676451 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1676485 INFO (searcherExecutor-4502-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@57ef52c7[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.7.0):c3/2:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=1.8.0_191,
java.vm.version=25.191-b12, lucene.version=7.7.0, os.arch=amd64,
java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-112-generic,
timestamp=1545331399396}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]:delGen=1)
Uninverting(_1(7.7.0):c3/2:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12,
lucene.version=7.7.0, os.arch=amd64, java.runtime.version=1.8.0_191-b12,
source=flush, os.version=4.4.0-112-generic,
timestamp=1545331399730}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]:delGen=1)
Uninverting(_2(7.7.0):c3/2:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12,
lucene.version=7.7.0, os.arch=amd64, java.runtime.version=1.8.0_191-b12,
source=flush, os.version=4.4.0-112-generic,
timestamp=1545331399928}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]:delGen=1)
Uninverting(_3(7.7.0):c3/2:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12,
lucene.version=7.7.0, os.arch=amd64, java.runtime.version=1.8.0_191-b12,
source=flush, os.version=4.4.0-112-generic,
timestamp=1545331400346}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]:delGen=1)))}
[junit4] 2> 1676486 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{commit=} 0 182
[junit4] 2> 1676487 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=0
[junit4] 2> 1676488 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[15 (1620397418624319488)]} 0 1
[junit4] 2> 1676488 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[15 (1620397418625368064)]} 0 0
[junit4] 2> 1676489 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={versions=true&wt=json&indent=true}{add=[15 (1620397418626416640)]} 0 0
[junit4] 2> 1676558 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={qt=/get&getVersions=200&wt=xml} status=0 QTime=69
[junit4] 2> 1676559 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1620397418698768384,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1676559 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@236ed664
commitCommandVersion:1620397418698768384
[junit4] 2> 1676727 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@11db46d7[collection1] main]
[junit4] 2> 1676728 INFO
(TEST-TestRecovery.testRemoveOldLogs-seed#[7388D8029F73B54C]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1676758 INFO (searcherExecutor-4502-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@11db46d7[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.7.0):c3/2:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=1.8.0_191,
java.vm.version=25.191-b12, lucene.version=7.7.0, os.arch=amd64,
java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-112-generic,
timestamp=1545331399396}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]:delGen=1)
Uninverting(_1(7.7.0):c3/2:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12,
lucene.version=7.7.0, os.arch=amd64, java.runtime.version=1.8.0_191-b12,
source=flush, os.version=4.4.0-112-generic,
timestamp=1545331399730}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]:delGen=1)
Uninverting(_2(7.7.0):c3/2:[diagnostics={os=Linux, java.vendor=Oracle
Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12,
lucene.version=7.7.0, os.arch=amd64, java.runtime.version=1.8.0_191-b12,
source=flush, os.version=4.4.0-112-generic,
timestamp=1545331399928}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]:delGen=1)
Uninverting(_3(7.7.0):c3/2:[diagnostics={os=Linux, java.vendor=Oracle Corpo
[...truncated too long message...]
erty disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
jar-checksums:
[mkdir] Created dir:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/null498554552
[copy] Copying 242 files to
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/null498554552
[delete] Deleting directory
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/null498554552
check-working-copy:
[ivy:cachepath] :: resolving dependencies ::
org.eclipse.jgit#org.eclipse.jgit-caller;working
[ivy:cachepath] confs: [default]
[ivy:cachepath] found
org.eclipse.jgit#org.eclipse.jgit;4.6.0.201612231935-r in public
[ivy:cachepath] found com.jcraft#jsch;0.1.53 in public
[ivy:cachepath] found com.googlecode.javaewah#JavaEWAH;1.1.6 in public
[ivy:cachepath] found org.apache.httpcomponents#httpclient;4.3.6 in
public
[ivy:cachepath] found org.apache.httpcomponents#httpcore;4.3.3 in public
[ivy:cachepath] found commons-logging#commons-logging;1.1.3 in public
[ivy:cachepath] found commons-codec#commons-codec;1.6 in public
[ivy:cachepath] found org.slf4j#slf4j-api;1.7.2 in public
[ivy:cachepath] :: resolution report :: resolve 147ms :: artifacts dl 14ms
---------------------------------------------------------------------
| | modules || artifacts |
| conf | number| search|dwnlded|evicted|| number|dwnlded|
---------------------------------------------------------------------
| default | 8 | 0 | 0 | 0 || 8 | 0 |
---------------------------------------------------------------------
[wc-checker] Initializing working copy...
[wc-checker] SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder".
[wc-checker] SLF4J: Defaulting to no-operation (NOP) logger implementation
[wc-checker] SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for
further details.
[wc-checker] Checking working copy status...
-jenkins-base:
BUILD SUCCESSFUL
Total time: 267 minutes 41 seconds
Archiving artifacts
java.lang.InterruptedException: no matches found within 10000
at hudson.FilePath$34.hasMatch(FilePath.java:2678)
at hudson.FilePath$34.invoke(FilePath.java:2557)
at hudson.FilePath$34.invoke(FilePath.java:2547)
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:2918)
Also: hudson.remoting.Channel$CallSiteStackTrace: Remote call to lucene2
at
hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1741)
at
hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:357)
at hudson.remoting.Channel.call(Channel.java:955)
at hudson.FilePath.act(FilePath.java:1036)
at hudson.FilePath.act(FilePath.java:1025)
at hudson.FilePath.validateAntFileMask(FilePath.java:2547)
at
hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243)
at
hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81)
at
hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at
hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744)
at
hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
at hudson.model.Build$BuildExecution.post2(Build.java:186)
at
hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
at hudson.model.Run.execute(Run.java:1819)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at
hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
Caused: hudson.FilePath$TunneledInterruptedException
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:2920)
at hudson.remoting.UserRequest.perform(UserRequest.java:212)
at hudson.remoting.UserRequest.perform(UserRequest.java:54)
at hudson.remoting.Request$2.run(Request.java:369)
at
hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:748)
Caused: java.lang.InterruptedException: java.lang.InterruptedException: no
matches found within 10000
at hudson.FilePath.act(FilePath.java:1038)
at hudson.FilePath.act(FilePath.java:1025)
at hudson.FilePath.validateAntFileMask(FilePath.java:2547)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243)
at
hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at
hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744)
at
hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
at hudson.model.Build$BuildExecution.post2(Build.java:186)
at
hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
at hudson.model.Run.execute(Run.java:1819)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
No artifacts found that match the file pattern
"**/*.events,heapdumps/**,**/hs_err_pid*". Configuration error?
Recording test results
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
