You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2021/09/14 21:47:29 UTC

[JENKINS] Lucene » Lucene-Solr-BadApples-NightlyTests-8.x - Build # 55 - Still Unstable!

Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-BadApples-NightlyTests-8.x/55/

1 tests failed.
FAILED:  org.apache.solr.handler.component.TestDistributedStatsComponentCardinality.test

Error Message:
.responseHeader.status:200!=0

Stack Trace:
junit.framework.AssertionFailedError: .responseHeader.status:200!=0
	at __randomizedtesting.SeedInfo.seed([ADC81870D6954A15:259C27AA786927ED]:0)
	at junit.framework.Assert.fail(Assert.java:57)
	at org.apache.solr.BaseDistributedSearchTestCase.compareSolrResponses(BaseDistributedSearchTestCase.java:1000)
	at org.apache.solr.BaseDistributedSearchTestCase.compareResponses(BaseDistributedSearchTestCase.java:1027)
	at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:673)
	at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:640)
	at org.apache.solr.handler.component.TestDistributedStatsComponentCardinality.test(TestDistributedStatsComponentCardinality.java:142)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1084)
	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1055)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.junit.rules.RunRules.evaluate(RunRules.java:20)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.junit.rules.RunRules.evaluate(RunRules.java:20)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.junit.rules.RunRules.evaluate(RunRules.java:20)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at org.junit.rules.RunRules.evaluate(RunRules.java:20)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 14264 lines...]
   [junit4] Suite: org.apache.solr.handler.component.TestDistributedStatsComponentCardinality
   [junit4]   2> 1288209 INFO  (SUITE-TestDistributedStatsComponentCardinality-seed#[ADC81870D6954A15]-worker) [     ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/server/solr/configsets/_default/conf'
   [junit4]   2> 1288210 INFO  (SUITE-TestDistributedStatsComponentCardinality-seed#[ADC81870D6954A15]-worker) [     ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/data-dir-44-001
   [junit4]   2> 1288210 WARN  (SUITE-TestDistributedStatsComponentCardinality-seed#[ADC81870D6954A15]-worker) [     ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=71 numCloses=71
   [junit4]   2> 1288210 INFO  (SUITE-TestDistributedStatsComponentCardinality-seed#[ADC81870D6954A15]-worker) [     ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 1288212 INFO  (SUITE-TestDistributedStatsComponentCardinality-seed#[ADC81870D6954A15]-worker) [     ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-9062)
   [junit4]   2> 1288212 INFO  (SUITE-TestDistributedStatsComponentCardinality-seed#[ADC81870D6954A15]-worker) [     ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 1288212 INFO  (SUITE-TestDistributedStatsComponentCardinality-seed#[ADC81870D6954A15]-worker) [     ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /a_rz/f
   [junit4]   2> 1288319 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/control/cores/collection1
   [junit4]   2> 1288330 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1288330 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 1288330 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
   [junit4]   2> 1288334 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1288335 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1288335 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1288335 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3961dcf{/a_rz/f,null,AVAILABLE}
   [junit4]   2> 1288335 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.AbstractConnector Started ServerConnector@5992120e{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:45337}
   [junit4]   2> 1288335 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.Server Started @1288422ms
   [junit4]   2> 1288335 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/a_rz/f, hostPort=45337, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/control/cores}
   [junit4]   2> 1288335 ERROR (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 1288335 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1288335 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.11.0
   [junit4]   2> 1288336 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 1288336 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr
   [junit4]   2> 1288336 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2021-09-14T20:02:36.364Z
   [junit4]   2> 1288336 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/control/solr.xml
   [junit4]   2> 1288338 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 1288338 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1288339 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@1ee4038, but no JMX reporters were configured - adding default JMX reporter.
   [junit4]   2> 1288737 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 1288738 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@2fc9e54d[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1288738 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@2fc9e54d[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1288741 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@253c5b41[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1288741 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@253c5b41[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1288743 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.CoreContainer Not all security plugins configured!  authentication=disabled authorization=disabled.  Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external.  See https://s.apache.org/solrsecurity for more info
   [junit4]   2> 1288754 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4
   [junit4]   2> 1288754 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 1288778 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1ee4038
   [junit4]   2> 1288785 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1ee4038
   [junit4]   2> 1288785 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1ee4038
   [junit4]   2> 1288786 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/control/cores
   [junit4]   2> 1288786 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1288795 INFO  (coreLoadExecutor-7339-thread-1) [    x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1288812 INFO  (coreLoadExecutor-7339-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
   [junit4]   2> 1288812 WARN  (coreLoadExecutor-7339-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
   [junit4]   2> 1288813 WARN  (coreLoadExecutor-7339-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead
   [junit4]   2> 1288816 INFO  (coreLoadExecutor-7339-thread-1) [    x:collection1 ] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 1288825 INFO  (coreLoadExecutor-7339-thread-1) [    x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1288832 INFO  (coreLoadExecutor-7339-thread-1) [    x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1, trusted=true
   [junit4]   2> 1288832 INFO  (coreLoadExecutor-7339-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@1ee4038
   [junit4]   2> 1288832 INFO  (coreLoadExecutor-7339-thread-1) [    x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/control/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/control/cores/collection1/data/]
   [junit4]   2> 1288834 INFO  (coreLoadExecutor-7339-thread-1) [    x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@a5182f
   [junit4]   2> 1288884 INFO  (coreLoadExecutor-7339-thread-1) [    x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1288884 INFO  (coreLoadExecutor-7339-thread-1) [    x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1288884 INFO  (coreLoadExecutor-7339-thread-1) [    x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=20, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=1.349609375, noCFSRatio=1.0]
   [junit4]   2> 1288886 INFO  (coreLoadExecutor-7339-thread-1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1288902 INFO  (coreLoadExecutor-7339-thread-1) [    x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1288970 INFO  (coreLoadExecutor-7339-thread-1) [    x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 1288973 INFO  (searcherExecutor-7341-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1288974 INFO  (searcherExecutor-7341-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1288974 INFO  (searcherExecutor-7341-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1288974 INFO  (searcherExecutor-7341-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1288974 INFO  (searcherExecutor-7341-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1288974 INFO  (searcherExecutor-7341-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1288974 INFO  (searcherExecutor-7341-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1288975 INFO  (searcherExecutor-7341-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1288975 INFO  (searcherExecutor-7341-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1288976 INFO  (searcherExecutor-7341-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 1289075 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard0/cores/collection1
   [junit4]   2> 1289076 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1289076 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 1289076 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
   [junit4]   2> 1289077 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1289077 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1289077 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1289077 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@73cd3e51{/a_rz/f,null,AVAILABLE}
   [junit4]   2> 1289077 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.AbstractConnector Started ServerConnector@42603b6d{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:37779}
   [junit4]   2> 1289077 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.Server Started @1289164ms
   [junit4]   2> 1289077 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/a_rz/f, hostPort=37779, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard0/cores}
   [junit4]   2> 1289077 ERROR (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 1289077 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1289078 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.11.0
   [junit4]   2> 1289078 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 1289078 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr
   [junit4]   2> 1289078 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2021-09-14T20:02:37.106Z
   [junit4]   2> 1289078 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard0/solr.xml
   [junit4]   2> 1289080 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 1289080 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1289081 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@1ee4038, but no JMX reporters were configured - adding default JMX reporter.
   [junit4]   2> 1289400 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 1289400 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@548caee1[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1289400 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@548caee1[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1289403 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@70bf18fb[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1289403 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@70bf18fb[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1289405 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.CoreContainer Not all security plugins configured!  authentication=disabled authorization=disabled.  Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external.  See https://s.apache.org/solrsecurity for more info
   [junit4]   2> 1289416 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4
   [junit4]   2> 1289417 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 1289437 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1ee4038
   [junit4]   2> 1289448 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1ee4038
   [junit4]   2> 1289449 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1ee4038
   [junit4]   2> 1289450 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard0/cores
   [junit4]   2> 1289450 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1289467 INFO  (coreLoadExecutor-7357-thread-1) [    x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1289484 INFO  (coreLoadExecutor-7357-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
   [junit4]   2> 1289484 WARN  (coreLoadExecutor-7357-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
   [junit4]   2> 1289485 WARN  (coreLoadExecutor-7357-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead
   [junit4]   2> 1289488 INFO  (coreLoadExecutor-7357-thread-1) [    x:collection1 ] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 1289495 INFO  (coreLoadExecutor-7357-thread-1) [    x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1289501 INFO  (coreLoadExecutor-7357-thread-1) [    x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1, trusted=true
   [junit4]   2> 1289502 INFO  (coreLoadExecutor-7357-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@1ee4038
   [junit4]   2> 1289502 INFO  (coreLoadExecutor-7357-thread-1) [    x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard0/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard0/cores/collection1/data/]
   [junit4]   2> 1289503 INFO  (coreLoadExecutor-7357-thread-1) [    x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@b3d2ce4
   [junit4]   2> 1289557 INFO  (coreLoadExecutor-7357-thread-1) [    x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1289557 INFO  (coreLoadExecutor-7357-thread-1) [    x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1289558 INFO  (coreLoadExecutor-7357-thread-1) [    x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=20, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=1.349609375, noCFSRatio=1.0]
   [junit4]   2> 1289559 INFO  (coreLoadExecutor-7357-thread-1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1289572 INFO  (coreLoadExecutor-7357-thread-1) [    x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1289640 INFO  (coreLoadExecutor-7357-thread-1) [    x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 1289640 INFO  (searcherExecutor-7359-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1289641 INFO  (searcherExecutor-7359-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1289641 INFO  (searcherExecutor-7359-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1289641 INFO  (searcherExecutor-7359-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1289641 INFO  (searcherExecutor-7359-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1289641 INFO  (searcherExecutor-7359-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1289642 INFO  (searcherExecutor-7359-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1289642 INFO  (searcherExecutor-7359-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1289642 INFO  (searcherExecutor-7359-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1289644 INFO  (searcherExecutor-7359-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 1289769 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard1/cores/collection1
   [junit4]   2> 1289771 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1289771 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 1289771 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
   [junit4]   2> 1289772 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1289772 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1289772 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 1289772 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4b926f2a{/a_rz/f,null,AVAILABLE}
   [junit4]   2> 1289773 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.AbstractConnector Started ServerConnector@2aec819a{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:33519}
   [junit4]   2> 1289773 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.Server Started @1289860ms
   [junit4]   2> 1289773 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/a_rz/f, hostPort=33519, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard1/cores}
   [junit4]   2> 1289773 ERROR (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 1289773 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1289773 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.11.0
   [junit4]   2> 1289773 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 1289773 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr
   [junit4]   2> 1289773 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2021-09-14T20:02:37.801Z
   [junit4]   2> 1289773 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard1/solr.xml
   [junit4]   2> 1289776 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 1289776 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1289777 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@1ee4038, but no JMX reporters were configured - adding default JMX reporter.
   [junit4]   2> 1289979 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 1289980 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@251af369[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1289980 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@251af369[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1289983 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@7fa417f7[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1289983 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@7fa417f7[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1289985 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.CoreContainer Not all security plugins configured!  authentication=disabled authorization=disabled.  Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external.  See https://s.apache.org/solrsecurity for more info
   [junit4]   2> 1289995 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4
   [junit4]   2> 1289995 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 1290016 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1ee4038
   [junit4]   2> 1290027 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1ee4038
   [junit4]   2> 1290027 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1ee4038
   [junit4]   2> 1290029 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard1/cores
   [junit4]   2> 1290029 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1290048 INFO  (coreLoadExecutor-7375-thread-1) [    x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1290064 INFO  (coreLoadExecutor-7375-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
   [junit4]   2> 1290064 WARN  (coreLoadExecutor-7375-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
   [junit4]   2> 1290065 WARN  (coreLoadExecutor-7375-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead
   [junit4]   2> 1290068 INFO  (coreLoadExecutor-7375-thread-1) [    x:collection1 ] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 1290075 INFO  (coreLoadExecutor-7375-thread-1) [    x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1290083 INFO  (coreLoadExecutor-7375-thread-1) [    x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1, trusted=true
   [junit4]   2> 1290084 INFO  (coreLoadExecutor-7375-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@1ee4038
   [junit4]   2> 1290084 INFO  (coreLoadExecutor-7375-thread-1) [    x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard1/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard1/cores/collection1/data/]
   [junit4]   2> 1290086 INFO  (coreLoadExecutor-7375-thread-1) [    x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@51a69d02
   [junit4]   2> 1290137 INFO  (coreLoadExecutor-7375-thread-1) [    x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1290137 INFO  (coreLoadExecutor-7375-thread-1) [    x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1290138 INFO  (coreLoadExecutor-7375-thread-1) [    x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=20, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=1.349609375, noCFSRatio=1.0]
   [junit4]   2> 1290139 INFO  (coreLoadExecutor-7375-thread-1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1290154 INFO  (coreLoadExecutor-7375-thread-1) [    x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1290215 INFO  (coreLoadExecutor-7375-thread-1) [    x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 1290215 INFO  (searcherExecutor-7377-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1290216 INFO  (searcherExecutor-7377-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1290216 INFO  (searcherExecutor-7377-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1290216 INFO  (searcherExecutor-7377-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1290216 INFO  (searcherExecutor-7377-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1290216 INFO  (searcherExecutor-7377-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1290216 INFO  (searcherExecutor-7377-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1290216 INFO  (searcherExecutor-7377-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1290217 INFO  (searcherExecutor-7377-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1290219 INFO  (searcherExecutor-7377-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 1290338 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard2/cores/collection1
   [junit4]   2> 1290339 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1290339 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 1290339 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
   [junit4]   2> 1290340 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1290340 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1290340 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 1290340 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@378a311b{/a_rz/f,null,AVAILABLE}
   [junit4]   2> 1290340 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.AbstractConnector Started ServerConnector@118bd1cf{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:46861}
   [junit4]   2> 1290341 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.Server Started @1290427ms
   [junit4]   2> 1290341 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/a_rz/f, hostPort=46861, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard2/cores}
   [junit4]   2> 1290341 ERROR (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 1290341 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1290341 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.11.0
   [junit4]   2> 1290341 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 1290341 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr
   [junit4]   2> 1290341 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2021-09-14T20:02:38.369Z
   [junit4]   2> 1290341 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard2/solr.xml
   [junit4]   2> 1290343 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 1290343 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1290345 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@1ee4038, but no JMX reporters were configured - adding default JMX reporter.
   [junit4]   2> 1290726 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 1290727 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@36e874c6[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1290727 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@36e874c6[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1290730 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@61f4e917[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1290730 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@61f4e917[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1290731 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.CoreContainer Not all security plugins configured!  authentication=disabled authorization=disabled.  Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external.  See https://s.apache.org/solrsecurity for more info
   [junit4]   2> 1290742 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4
   [junit4]   2> 1290742 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 1290761 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1ee4038
   [junit4]   2> 1290772 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1ee4038
   [junit4]   2> 1290772 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1ee4038
   [junit4]   2> 1290774 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard2/cores
   [junit4]   2> 1290774 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1290792 INFO  (coreLoadExecutor-7393-thread-1) [    x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1290808 INFO  (coreLoadExecutor-7393-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
   [junit4]   2> 1290809 WARN  (coreLoadExecutor-7393-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
   [junit4]   2> 1290809 WARN  (coreLoadExecutor-7393-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead
   [junit4]   2> 1290812 INFO  (coreLoadExecutor-7393-thread-1) [    x:collection1 ] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 1290819 INFO  (coreLoadExecutor-7393-thread-1) [    x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1290825 INFO  (coreLoadExecutor-7393-thread-1) [    x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1, trusted=true
   [junit4]   2> 1290826 INFO  (coreLoadExecutor-7393-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@1ee4038
   [junit4]   2> 1290826 INFO  (coreLoadExecutor-7393-thread-1) [    x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard2/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard2/cores/collection1/data/]
   [junit4]   2> 1290828 INFO  (coreLoadExecutor-7393-thread-1) [    x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@47eaf58a
   [junit4]   2> 1290885 INFO  (coreLoadExecutor-7393-thread-1) [    x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1290885 INFO  (coreLoadExecutor-7393-thread-1) [    x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1290886 INFO  (coreLoadExecutor-7393-thread-1) [    x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=20, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=1.349609375, noCFSRatio=1.0]
   [junit4]   2> 1290887 INFO  (coreLoadExecutor-7393-thread-1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1290901 INFO  (coreLoadExecutor-7393-thread-1) [    x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1290967 INFO  (coreLoadExecutor-7393-thread-1) [    x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 1290967 INFO  (searcherExecutor-7395-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1290967 INFO  (searcherExecutor-7395-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1290967 INFO  (searcherExecutor-7395-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1290967 INFO  (searcherExecutor-7395-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1290967 INFO  (searcherExecutor-7395-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1290968 INFO  (searcherExecutor-7395-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1290968 INFO  (searcherExecutor-7395-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1290968 INFO  (searcherExecutor-7395-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1290968 INFO  (searcherExecutor-7395-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1290970 INFO  (searcherExecutor-7395-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 1291074 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard3/cores/collection1
   [junit4]   2> 1291075 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1291075 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 1291075 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
   [junit4]   2> 1291076 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1291076 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1291076 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 1291077 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7591e33e{/a_rz/f,null,AVAILABLE}
   [junit4]   2> 1291077 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.AbstractConnector Started ServerConnector@60c2a018{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:44725}
   [junit4]   2> 1291077 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.Server Started @1291164ms
   [junit4]   2> 1291077 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/a_rz/f, hostPort=44725, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard3/cores}
   [junit4]   2> 1291077 ERROR (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 1291077 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1291078 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.11.0
   [junit4]   2> 1291078 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 1291078 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr
   [junit4]   2> 1291078 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2021-09-14T20:02:39.106Z
   [junit4]   2> 1291078 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard3/solr.xml
   [junit4]   2> 1291081 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 1291081 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1291083 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@1ee4038, but no JMX reporters were configured - adding default JMX reporter.
   [junit4]   2> 1291337 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 1291337 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@62d11f69[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1291337 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@62d11f69[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1291341 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@47fa0282[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1291341 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@47fa0282[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1291342 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.CoreContainer Not all security plugins configured!  authentication=disabled authorization=disabled.  Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external.  See https://s.apache.org/solrsecurity for more info
   [junit4]   2> 1291352 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4
   [junit4]   2> 1291352 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 1291371 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1ee4038
   [junit4]   2> 1291390 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1ee4038
   [junit4]   2> 1291390 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1ee4038
   [junit4]   2> 1291391 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard3/cores
   [junit4]   2> 1291391 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1291400 INFO  (coreLoadExecutor-7411-thread-1) [    x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1291417 INFO  (coreLoadExecutor-7411-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
   [junit4]   2> 1291417 WARN  (coreLoadExecutor-7411-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
   [junit4]   2> 1291418 WARN  (coreLoadExecutor-7411-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead
   [junit4]   2> 1291421 INFO  (coreLoadExecutor-7411-thread-1) [    x:collection1 ] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 1291428 INFO  (coreLoadExecutor-7411-thread-1) [    x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1291434 INFO  (coreLoadExecutor-7411-thread-1) [    x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1, trusted=true
   [junit4]   2> 1291434 INFO  (coreLoadExecutor-7411-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@1ee4038
   [junit4]   2> 1291434 INFO  (coreLoadExecutor-7411-thread-1) [    x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard3/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard3/cores/collection1/data/]
   [junit4]   2> 1291436 INFO  (coreLoadExecutor-7411-thread-1) [    x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@578f7f55
   [junit4]   2> 1291490 INFO  (coreLoadExecutor-7411-thread-1) [    x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1291490 INFO  (coreLoadExecutor-7411-thread-1) [    x:collection1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1291490 INFO  (coreLoadExecutor-7411-thread-1) [    x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=20, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=1.349609375, noCFSRatio=1.0]
   [junit4]   2> 1291492 INFO  (coreLoadExecutor-7411-thread-1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1291506 INFO  (coreLoadExecutor-7411-thread-1) [    x:collection1 ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1291574 INFO  (coreLoadExecutor-7411-thread-1) [    x:collection1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 1291574 INFO  (searcherExecutor-7413-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1291575 INFO  (searcherExecutor-7413-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1291575 INFO  (searcherExecutor-7413-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1291575 INFO  (searcherExecutor-7413-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1291575 INFO  (searcherExecutor-7413-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1291575 INFO  (searcherExecutor-7413-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1291577 INFO  (searcherExecutor-7413-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1291577 INFO  (searcherExecutor-7413-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1291577 INFO  (searcherExecutor-7413-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1291579 INFO  (searcherExecutor-7413-thread-1-processing-x:collection1) [    x:collection1 ] o.a.s.c.SolrCore [collection1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 1291677 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard4/cores/collection1
   [junit4]   2> 1291677 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1291678 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 1291678 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
   [junit4]   2> 1291678 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1291678 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1291678 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 1291679 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6523aa75{/a_rz/f,null,AVAILABLE}
   [junit4]   2> 1291679 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.AbstractConnector Started ServerConnector@7d6b1ce8{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:36891}
   [junit4]   2> 1291679 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.s.Server Started @1291766ms
   [junit4]   2> 1291679 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/a_rz/f, hostPort=36891, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard4/cores}
   [junit4]   2> 1291679 ERROR (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 1291679 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1291679 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 8.11.0
   [junit4]   2> 1291679 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 1291679 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr
   [junit4]   2> 1291679 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2021-09-14T20:02:39.707Z
   [junit4]   2> 1291680 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard4/solr.xml
   [junit4]   2> 1291682 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 1291682 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 1291683 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@1ee4038, but no JMX reporters were configured - adding default JMX reporter.
   [junit4]   2> 1292153 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 1292153 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@54938043[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1292153 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@54938043[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1292156 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@60e628a7[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1292156 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@60e628a7[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1292158 WARN  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.CoreContainer Not all security plugins configured!  authentication=disabled authorization=disabled.  Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external.  See https://s.apache.org/solrsecurity for more info
   [junit4]   2> 1292169 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4
   [junit4]   2> 1292169 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 1292198 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1ee4038
   [junit4]   2> 1292209 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1ee4038
   [junit4]   2> 1292209 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1ee4038
   [junit4]   2> 1292211 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard4/cores
   [junit4]   2> 1292211 INFO  (TEST-TestDistributedStatsComponentCardinality.test-seed#[ADC81870D6954A15]) [     ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1292220 INFO  (coreLoadExecutor-7429-thread-1) [    x:collection1 ] o.a.s.c.SolrResourceLoader Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1292240 INFO  (coreLoadExecutor-7429-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.11.0
   [junit4]   2> 1292240 WARN  (coreLoadExecutor-7429-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <boolTofilterOptimizer> is currently not implemented and has no effect.
   [junit4]   2> 1292242 WARN  (coreLoadExecutor-7429-thread-1) [    x:collection1 ] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead
   [junit4]   2> 1292245 INFO  (coreLoadExecutor-7429-thread-1) [    x:collection1 ] o.a.s.s.IndexSchema Schema name=test
   [junit4]   2> 1292252 INFO  (coreLoadExecutor-7429-thread-1) [    x:collection1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1292258 INFO  (coreLoadExecutor-7429-thread-1) [    x:collection1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/core/src/test-files/solr/collection1, trusted=true
   [junit4]   2> 1292258 INFO  (coreLoadExecutor-7429-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@1ee4038
   [junit4]   2> 1292259 INFO  (coreLoadExecutor-7429-thread-1) [    x:collection1 ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard4/cores/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001/tempDir-001/shard4/cores/collection1/data/]
   [junit4]   2> 1292261 INFO  (coreLoadExecutor-7429-thread-1) [    x:collection1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@4efbfe21
   [junit4]   2> 1292312 INFO  (coreLoadExecutor-7429-thread-1) [    x:collection1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1292312 INFO  (coreLoadExecutor-7429-thread-1) [    x:collection1 ] o.a.s.u.CommitTr

[...truncated too long message...]

 domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@2e7ca6a1
   [junit4]   2> 1364164 INFO  (closeThreadPool-7478-thread-7) [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
   [junit4]   2> 1364164 INFO  (closeThreadPool-7478-thread-7) [     ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@162773f: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@75a44ac7
   [junit4]   2> 1364164 INFO  (closeThreadPool-7478-thread-6) [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
   [junit4]   2> 1364164 INFO  (closeThreadPool-7478-thread-6) [     ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@51b3b42b: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@75a44ac7
   [junit4]   2> 1364166 INFO  (closeThreadPool-7478-thread-10) [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
   [junit4]   2> 1364166 INFO  (closeThreadPool-7478-thread-10) [     ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@23a3ec46: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@3f587024
   [junit4]   2> 1364182 INFO  (closeThreadPool-7478-thread-10) [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
   [junit4]   2> 1364182 INFO  (closeThreadPool-7478-thread-10) [     ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4b568138: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@2e7ca6a1
   [junit4]   2> 1364193 INFO  (closeThreadPool-7478-thread-10) [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
   [junit4]   2> 1364193 INFO  (closeThreadPool-7478-thread-10) [     ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@250361df: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@75a44ac7
   [junit4]   2> 1364206 INFO  (closeThreadPool-7478-thread-4) [     ] o.e.j.s.AbstractConnector Stopped ServerConnector@60c2a018{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
   [junit4]   2> 1364207 INFO  (closeThreadPool-7478-thread-3) [     ] o.e.j.s.AbstractConnector Stopped ServerConnector@17f01de3{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
   [junit4]   2> 1364208 INFO  (closeThreadPool-7478-thread-8) [     ] o.e.j.s.AbstractConnector Stopped ServerConnector@2aec819a{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
   [junit4]   2> 1364209 INFO  (closeThreadPool-7478-thread-4) [     ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@7591e33e{/a_rz/f,null,STOPPED}
   [junit4]   2> 1364209 INFO  (closeThreadPool-7478-thread-4) [     ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1364210 INFO  (closeThreadPool-7478-thread-3) [     ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@33e0cb32{/a_rz/f,null,STOPPED}
   [junit4]   2> 1364210 INFO  (closeThreadPool-7478-thread-3) [     ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1364216 INFO  (closeThreadPool-7478-thread-8) [     ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@4b926f2a{/a_rz/f,null,STOPPED}
   [junit4]   2> 1364216 INFO  (closeThreadPool-7478-thread-8) [     ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1364217 INFO  (closeThreadPool-7478-thread-7) [     ] o.e.j.s.AbstractConnector Stopped ServerConnector@118bd1cf{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
   [junit4]   2> 1364219 INFO  (closeThreadPool-7478-thread-7) [     ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@378a311b{/a_rz/f,null,STOPPED}
   [junit4]   2> 1364219 INFO  (closeThreadPool-7478-thread-7) [     ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1364221 INFO  (closeThreadPool-7478-thread-6) [     ] o.e.j.s.AbstractConnector Stopped ServerConnector@7d6b1ce8{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
   [junit4]   2> 1364222 INFO  (closeThreadPool-7478-thread-6) [     ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@6523aa75{/a_rz/f,null,STOPPED}
   [junit4]   2> 1364222 INFO  (closeThreadPool-7478-thread-6) [     ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1364222 INFO  (closeThreadPool-7478-thread-9) [     ] o.e.j.s.AbstractConnector Stopped ServerConnector@42603b6d{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
   [junit4]   2> 1364224 INFO  (closeThreadPool-7478-thread-9) [     ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@73cd3e51{/a_rz/f,null,STOPPED}
   [junit4]   2> 1364224 INFO  (closeThreadPool-7478-thread-9) [     ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1364225 INFO  (closeThreadPool-7478-thread-10) [     ] o.e.j.s.AbstractConnector Stopped ServerConnector@cfae3d8{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
   [junit4]   2> 1364226 INFO  (closeThreadPool-7478-thread-10) [     ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@510e9318{/a_rz/f,null,STOPPED}
   [junit4]   2> 1364226 INFO  (closeThreadPool-7478-thread-10) [     ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> NOTE: download the large Jenkins line-docs file by running 'ant get-jenkins-line-docs' in the lucene directory.
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestDistributedStatsComponentCardinality -Dtests.method=test -Dtests.seed=ADC81870D6954A15 -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.badapples=true -Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/test-data/enwiki.random.lines.txt -Dtests.locale=es-CO -Dtests.timezone=America/Tijuana -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] FAILURE 76.0s J3 | TestDistributedStatsComponentCardinality.test <<<
   [junit4]    > Throwable #1: junit.framework.AssertionFailedError: .responseHeader.status:200!=0
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([ADC81870D6954A15:259C27AA786927ED]:0)
   [junit4]    > 	at junit.framework.Assert.fail(Assert.java:57)
   [junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase.compareSolrResponses(BaseDistributedSearchTestCase.java:1000)
   [junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase.compareResponses(BaseDistributedSearchTestCase.java:1027)
   [junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:673)
   [junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:640)
   [junit4]    > 	at org.apache.solr.handler.component.TestDistributedStatsComponentCardinality.test(TestDistributedStatsComponentCardinality.java:142)
   [junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1084)
   [junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1055)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/solr-core/test/J3/temp/solr.handler.component.TestDistributedStatsComponentCardinality_ADC81870D6954A15-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene87): {multiDefault=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), _root_=FST50, string_s=BlockTreeOrds(blocksize=128), id=PostingsFormat(name=Asserting)}, docValues:{int_i=DocValuesFormat(name=Direct), long_l=DocValuesFormat(name=Lucene80), range_facet_l_dv=DocValuesFormat(name=Lucene80), string_s_prehashed_l=DocValuesFormat(name=Lucene80), intDefault=DocValuesFormat(name=Lucene80), id_i1=DocValuesFormat(name=Asserting), int_i_prehashed_l=DocValuesFormat(name=Direct), range_facet_i_dv=DocValuesFormat(name=Lucene80), intDvoDefault=DocValuesFormat(name=Direct), timestamp=DocValuesFormat(name=Lucene80), range_facet_l=DocValuesFormat(name=Lucene80), long_l_prehashed_l=DocValuesFormat(name=Direct)}, maxPointsInLeafNode=770, maxMBSortInHeap=7.730703618001238, sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=es-CO, timezone=America/Tijuana
   [junit4]   2> NOTE: Linux 4.15.0-147-generic amd64/Oracle Corporation 1.8.0_291 (64-bit)/cpus=4,threads=1,free=87794992,total=529006592
   [junit4]   2> NOTE: All tests run in this JVM: [TestOverriddenPrefixQueryForCustomFieldType, ReplaceNodeNoTargetTest, TestSimPolicyCloud, TestExactSharedStatsCache, BJQFilterAccessibleTest, IndexSizeTriggerMixedBoundsTest, DistributedFacetPivotLongTailTest, CollectionsAPIDistributedZkTest, OverseerTaskQueueTest, JWTAuthPluginIntegrationTest, HdfsChaosMonkeyNothingIsSafeTest, TemplateUpdateProcessorTest, TestRequestForwarding, WrapperMergePolicyFactoryTest, DirectoryFactoryTest, TestSolrCLIRunExample, BlockJoinFacetRandomTest, TestStreamBody, TestSolrJ, MetricsHandlerTest, TlogReplayBufferedWhileIndexingTest, TestSweetSpotSimilarityFactory, CdcrOpsAndBoundariesTest, DistributedDebugComponentTest, SharedFSAutoReplicaFailoverTest, InfixSuggestersTest, TestPhraseSuggestions, TestFieldCollectionResource, QueryElevationComponentTest, CachingDirectoryFactoryTest, WordBreakSolrSpellCheckerTest, TestBulkSchemaAPI, TestDistributedStatsComponentCardinality]
   [junit4] Completed [326/947 (1!)] on J3 in 76.06s, 1 test, 1 failure <<< FAILURES!

[...truncated 56362 lines...]

[JENKINS] Lucene » Lucene-Solr-BadApples-NightlyTests-8.x - Build # 56 - Still Unstable!

Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-BadApples-NightlyTests-8.x/56/

1 tests failed.
FAILED:  org.apache.solr.s3.S3IncrementalBackupTest.testRestoreToOriginalCollection

Error Message:
expected:<COMPLETED> but was:<FAILED>

Stack Trace:
java.lang.AssertionError: expected:<COMPLETED> but was:<FAILED>
	at __randomizedtesting.SeedInfo.seed([FAD08ED5C75C377F:CF24658E2C800121]:0)
	at org.junit.Assert.fail(Assert.java:89)
	at org.junit.Assert.failNotEquals(Assert.java:835)
	at org.junit.Assert.assertEquals(Assert.java:120)
	at org.junit.Assert.assertEquals(Assert.java:146)
	at org.apache.solr.cloud.api.collections.AbstractIncrementalBackupTest.testRestoreToOriginalCollection(AbstractIncrementalBackupTest.java:201)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.junit.rules.RunRules.evaluate(RunRules.java:20)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.junit.rules.RunRules.evaluate(RunRules.java:20)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
	at com.adobe.testing.s3mock.junit4.S3MockRule$1.evaluate(S3MockRule.java:66)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.junit.rules.RunRules.evaluate(RunRules.java:20)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at org.junit.rules.RunRules.evaluate(RunRules.java:20)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 25855 lines...]
   [junit4] Suite: org.apache.solr.s3.S3IncrementalBackupTest
   [junit4]   2> 9838 INFO  (SUITE-S3IncrementalBackupTest-seed#[FAD08ED5C75C377F]-worker) [    ] o.e.j.u.log Logging initialized @9861ms to org.eclipse.jetty.util.log.Slf4jLog
   [junit4]   2> 10760 INFO  (SUITE-S3IncrementalBackupTest-seed#[FAD08ED5C75C377F]-worker) [    ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
   [junit4]   2> 10850 INFO  (SUITE-S3IncrementalBackupTest-seed#[FAD08ED5C75C377F]-worker) [    ] o.e.j.s.h.C.application Initializing Spring embedded WebApplicationContext
   [junit4]   2> 11569 INFO  (SUITE-S3IncrementalBackupTest-seed#[FAD08ED5C75C377F]-worker) [    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 11570 INFO  (SUITE-S3IncrementalBackupTest-seed#[FAD08ED5C75C377F]-worker) [    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 11574 INFO  (SUITE-S3IncrementalBackupTest-seed#[FAD08ED5C75C377F]-worker) [    ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 11591 INFO  (SUITE-S3IncrementalBackupTest-seed#[FAD08ED5C75C377F]-worker) [    ] o.e.j.s.h.ContextHandler Started o.s.b.w.e.j.JettyEmbeddedWebAppContext@6c72a9ba{application,/,[file:///home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/contrib/solr-s3-repository/test/J2/temp/jetty-docbase.0.5175493132766708912/],AVAILABLE}
   [junit4]   2> 11591 INFO  (SUITE-S3IncrementalBackupTest-seed#[FAD08ED5C75C377F]-worker) [    ] o.e.j.s.Server Started @11621ms
   [junit4]   2> 13432 INFO  (SUITE-S3IncrementalBackupTest-seed#[FAD08ED5C75C377F]-worker) [    ] o.e.j.s.h.C.application Initializing Spring DispatcherServlet 'dispatcherServlet'
   [junit4]   2> 13796 INFO  (SUITE-S3IncrementalBackupTest-seed#[FAD08ED5C75C377F]-worker) [    ] o.e.j.u.s.SslContextFactory x509=X509@58190cb(selfsigned,h=[],w=[]) for Server@2cc818f4[provider=null,keyStore=jar:file:/home/jenkins/.ivy2/cache/com.adobe.testing/s3mock/jars/s3mock-2.1.34.jar!/s3mock.jks,trustStore=null]
   [junit4]   2> 14367 INFO  (SUITE-S3IncrementalBackupTest-seed#[FAD08ED5C75C377F]-worker) [    ] o.e.j.s.AbstractConnector Started SslValidatingServerConnector@16d45ab2{SSL, (ssl, http/1.1)}{0.0.0.0:46737}
   [junit4]   2> 14371 INFO  (SUITE-S3IncrementalBackupTest-seed#[FAD08ED5C75C377F]-worker) [    ] o.e.j.s.AbstractConnector Started ServerConnector@4b82d098{HTTP/1.1, (http/1.1)}{0.0.0.0:41943}
   [junit4]   2> 14848 WARN  (SUITE-S3IncrementalBackupTest-seed#[FAD08ED5C75C377F]-worker) [    ] o.a.s.c.ZkTestServer TEST_HOME() does not exist - solrj test?
   [junit4]   2> 14941 WARN  (ZkTestServer Run Thread) [    ] o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
   [junit4]   2> 15378 WARN  (SUITE-S3IncrementalBackupTest-seed#[FAD08ED5C75C377F]-worker-SendThread(127.0.0.1:38913)) [    ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10163a991960002.
   [junit4]   2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x10163a991960002, likely server has closed socket
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 15518 INFO  (jetty-launcher-8-thread-2) [    ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
   [junit4]   2> 15518 INFO  (jetty-launcher-8-thread-1) [    ] o.e.j.s.Server jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 1.8.0_291-b10
   [junit4]   2> 15616 INFO  (jetty-launcher-8-thread-2) [    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 15616 INFO  (jetty-launcher-8-thread-2) [    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 15616 INFO  (jetty-launcher-8-thread-2) [    ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 15618 INFO  (jetty-launcher-8-thread-1) [    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 15618 INFO  (jetty-launcher-8-thread-1) [    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 15618 INFO  (jetty-launcher-8-thread-1) [    ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 15623 INFO  (jetty-launcher-8-thread-2) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@693c4822{/solr,null,AVAILABLE}
   [junit4]   2> 15629 INFO  (jetty-launcher-8-thread-1) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5a24da24{/solr,null,AVAILABLE}
   [junit4]   2> 15633 INFO  (jetty-launcher-8-thread-1) [    ] o.e.j.s.AbstractConnector Started ServerConnector@57cc44a5{SSL, (ssl, http/1.1)}{127.0.0.1:35485}
   [junit4]   2> 15633 INFO  (jetty-launcher-8-thread-2) [    ] o.e.j.s.AbstractConnector Started ServerConnector@543e45f5{SSL, (ssl, http/1.1)}{127.0.0.1:38301}
   [junit4]   2> 15633 INFO  (jetty-launcher-8-thread-1) [    ] o.e.j.s.Server Started @15663ms
   [junit4]   2> 15633 INFO  (jetty-launcher-8-thread-2) [    ] o.e.j.s.Server Started @15663ms
   [junit4]   2> 15711 ERROR (jetty-launcher-8-thread-1) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 15712 ERROR (jetty-launcher-8-thread-2) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 15835 WARN  (jetty-launcher-8-thread-1-SendThread(127.0.0.1:38913)) [    ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10163a991960003.
   [junit4]   2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x10163a991960003, likely server has closed socket
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 15835 WARN  (jetty-launcher-8-thread-2-SendThread(127.0.0.1:38913)) [    ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10163a991960004.
   [junit4]   2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x10163a991960004, likely server has closed socket
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 17577 WARN  (jetty-launcher-8-thread-1) [    ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 18057 WARN  (jetty-launcher-8-thread-1) [    ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 18420 WARN  (jetty-launcher-8-thread-2) [    ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 18456 WARN  (jetty-launcher-8-thread-2) [    ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 18758 WARN  (jetty-launcher-8-thread-1-SendThread(127.0.0.1:38913)) [    ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10163a991960005.
   [junit4]   2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x10163a991960005, likely server has closed socket
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 18759 WARN  (jetty-launcher-8-thread-2-SendThread(127.0.0.1:38913)) [    ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10163a991960006.
   [junit4]   2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x10163a991960006, likely server has closed socket
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 19289 WARN  (jetty-launcher-8-thread-1) [n:127.0.0.1:35485_solr    ] o.a.s.c.ZkController Contents of zookeeper /security.json are world-readable; consider setting up ACLs as described in https://solr.apache.org/guide/zookeeper-access-control.html
   [junit4]   2> 19372 WARN  (jetty-launcher-8-thread-2) [n:127.0.0.1:38301_solr    ] o.a.s.c.ZkController Contents of zookeeper /security.json are world-readable; consider setting up ACLs as described in https://solr.apache.org/guide/zookeeper-access-control.html
   [junit4]   2> 19782 WARN  (jetty-launcher-8-thread-2) [n:127.0.0.1:38301_solr    ] o.a.s.c.CoreContainer Not all security plugins configured!  authentication=disabled authorization=disabled.  Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external.  See https://s.apache.org/solrsecurity for more info
   [junit4]   2> 19797 WARN  (jetty-launcher-8-thread-1) [n:127.0.0.1:35485_solr    ] o.a.s.c.CoreContainer Not all security plugins configured!  authentication=disabled authorization=disabled.  Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external.  See https://s.apache.org/solrsecurity for more info
   [junit4]   2> 33589 ERROR (qtp1695573696-23) [    ] c.a.t.s.d.FileStore File can not be read
   [junit4]   2> com.fasterxml.jackson.databind.exc.MismatchedInputException: No content to map due to end-of-input
   [junit4]   2>  at [Source: (File); line: 1, column: 0]
   [junit4]   2> 	at com.fasterxml.jackson.databind.exc.MismatchedInputException.from(MismatchedInputException.java:59) ~[jackson-databind-2.12.3.jar:2.12.3]
   [junit4]   2> 	at com.fasterxml.jackson.databind.ObjectMapper._initForReading(ObjectMapper.java:4688) ~[jackson-databind-2.12.3.jar:2.12.3]
   [junit4]   2> 	at com.fasterxml.jackson.databind.ObjectMapper._readMapAndClose(ObjectMapper.java:4586) ~[jackson-databind-2.12.3.jar:2.12.3]
   [junit4]   2> 	at com.fasterxml.jackson.databind.ObjectMapper.readValue(ObjectMapper.java:3413) ~[jackson-databind-2.12.3.jar:2.12.3]
   [junit4]   2> 	at com.adobe.testing.s3mock.domain.FileStore.getS3Object(FileStore.java:510) ~[s3mock-2.1.34.jar:?]
   [junit4]   2> 	at com.adobe.testing.s3mock.FileStoreController.headObject(FileStoreController.java:257) ~[s3mock-2.1.34.jar:?]
   [junit4]   2> 	at sun.reflect.GeneratedMethodAccessor64.invoke(Unknown Source) ~[?:?]
   [junit4]   2> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_291]
   [junit4]   2> 	at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_291]
   [junit4]   2> 	at org.springframework.web.method.support.InvocableHandlerMethod.doInvoke(InvocableHandlerMethod.java:190) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.method.support.InvocableHandlerMethod.invokeForRequest(InvocableHandlerMethod.java:138) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.mvc.method.annotation.ServletInvocableHandlerMethod.invokeAndHandle(ServletInvocableHandlerMethod.java:105) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.invokeHandlerMethod(RequestMappingHandlerAdapter.java:878) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.handleInternal(RequestMappingHandlerAdapter.java:792) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.mvc.method.AbstractHandlerMethodAdapter.handle(AbstractHandlerMethodAdapter.java:87) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:1040) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:943) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:1006) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.FrameworkServlet.doGet(FrameworkServlet.java:898) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at javax.servlet.http.HttpServlet.doHead(HttpServlet.java:288) ~[javax.servlet-api-3.1.0.jar:3.1.0]
   [junit4]   2> 	at javax.servlet.http.HttpServlet.service(HttpServlet.java:704) ~[javax.servlet-api-3.1.0.jar:3.1.0]
   [junit4]   2> 	at org.springframework.web.servlet.FrameworkServlet.service(FrameworkServlet.java:883) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at javax.servlet.http.HttpServlet.service(HttpServlet.java:790) ~[javax.servlet-api-3.1.0.jar:3.1.0]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:799) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$ChainEnd.doFilter(ServletHandler.java:1626) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at com.adobe.testing.s3mock.KmsValidationFilter.doFilterInternal(KmsValidationFilter.java:91) ~[s3mock-2.1.34.jar:?]
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.springframework.web.filter.RequestContextFilter.doFilterInternal(RequestContextFilter.java:100) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:103) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.springframework.boot.actuate.metrics.web.servlet.WebMvcMetricsFilter.doFilterInternal(WebMvcMetricsFilter.java:97) ~[spring-boot-actuator-2.3.12.RELEASE.jar:2.3.12.RELEASE]
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.springframework.web.filter.CharacterEncodingFilter.doFilterInternal(CharacterEncodingFilter.java:201) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:548) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:602) ~[jetty-security-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:235) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1624) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1435) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:501) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1594) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1350) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.Server.handle(Server.java:516) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:388) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:633) [jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:380) [jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:277) [jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311) [jetty-io-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:105) [jetty-io-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.io.ChannelEndPoint$1.run(ChannelEndPoint.java:104) [jetty-io-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.runTask(EatWhatYouKill.java:336) [jetty-util-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:313) [jetty-util-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171) [jetty-util-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:129) [jetty-util-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:383) [jetty-util-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:882) [jetty-util-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:1036) [jetty-util-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:748) [?:1.8.0_291]
   [junit4]   2> com.fasterxml.jackson.databind.exc.MismatchedInputException: No content to map due to end-of-input
   [junit4]   2>  at [Source: (File); line: 1, column: 0]
   [junit4]   2> 	at com.fasterxml.jackson.databind.exc.MismatchedInputException.from(MismatchedInputException.java:59)
   [junit4]   2> 	at com.fasterxml.jackson.databind.ObjectMapper._initForReading(ObjectMapper.java:4688)
   [junit4]   2> 	at com.fasterxml.jackson.databind.ObjectMapper._readMapAndClose(ObjectMapper.java:4586)
   [junit4]   2> 	at com.fasterxml.jackson.databind.ObjectMapper.readValue(ObjectMapper.java:3413)
   [junit4]   2> 	at com.adobe.testing.s3mock.domain.FileStore.getS3Object(FileStore.java:510)
   [junit4]   2> 	at com.adobe.testing.s3mock.FileStoreController.headObject(FileStoreController.java:257)
   [junit4]   2> 	at sun.reflect.GeneratedMethodAccessor64.invoke(Unknown Source)
   [junit4]   2> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2> 	at java.lang.reflect.Method.invoke(Method.java:498)
   [junit4]   2> 	at org.springframework.web.method.support.InvocableHandlerMethod.doInvoke(InvocableHandlerMethod.java:190)
   [junit4]   2> 	at org.springframework.web.method.support.InvocableHandlerMethod.invokeForRequest(InvocableHandlerMethod.java:138)
   [junit4]   2> 	at org.springframework.web.servlet.mvc.method.annotation.ServletInvocableHandlerMethod.invokeAndHandle(ServletInvocableHandlerMethod.java:105)
   [junit4]   2> 	at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.invokeHandlerMethod(RequestMappingHandlerAdapter.java:878)
   [junit4]   2> 	at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.handleInternal(RequestMappingHandlerAdapter.java:792)
   [junit4]   2> 	at org.springframework.web.servlet.mvc.method.AbstractHandlerMethodAdapter.handle(AbstractHandlerMethodAdapter.java:87)
   [junit4]   2> 	at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:1040)
   [junit4]   2> 	at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:943)
   [junit4]   2> 	at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:1006)
   [junit4]   2> 	at org.springframework.web.servlet.FrameworkServlet.doGet(FrameworkServlet.java:898)
   [junit4]   2> 	at javax.servlet.http.HttpServlet.doHead(HttpServlet.java:288)
   [junit4]   2> 	at javax.servlet.http.HttpServlet.service(HttpServlet.java:704)
   [junit4]   2> 	at org.springframework.web.servlet.FrameworkServlet.service(FrameworkServlet.java:883)
   [junit4]   2> 	at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:799)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$ChainEnd.doFilter(ServletHandler.java:1626)
   [junit4]   2> 	at com.adobe.testing.s3mock.KmsValidationFilter.doFilterInternal(KmsValidationFilter.java:91)
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119)
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601)
   [junit4]   2> 	at org.springframework.web.filter.RequestContextFilter.doFilterInternal(RequestContextFilter.java:100)
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119)
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601)
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:103)
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601)
   [junit4]   2> 	at org.springframework.boot.actuate.metrics.web.servlet.WebMvcMetricsFilter.doFilterInternal(WebMvcMetricsFilter.java:97)
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119)
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601)
   [junit4]   2> 	at org.springframework.web.filter.CharacterEncodingFilter.doFilterInternal(CharacterEncodingFilter.java:201)
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119)
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:548)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
   [junit4]   2> 	at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:602)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:235)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1624)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1435)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:501)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1594)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1350)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
   [junit4]   2> 	at org.eclipse.jetty.server.Server.handle(Server.java:516)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:388)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:633)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:380)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:277)
   [junit4]   2> 	at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311)
   [junit4]   2> 	at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:105)
   [junit4]   2> 	at org.eclipse.jetty.io.ChannelEndPoint$1.run(ChannelEndPoint.java:104)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.runTask(EatWhatYouKill.java:336)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:313)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:129)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:383)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:882)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:1036)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 36850 WARN  (OverseerThreadFactory-48-thread-3-processing-n:127.0.0.1:35485_solr) [n:127.0.0.1:35485_solr c:backuprestore_testbackupinc_restored   ] o.a.s.c.a.c.CreateCollectionCmd It is unusual to create a collection (backuprestore_testbackupinc_restored) without cores.
   [junit4]   2> 38934 WARN  (recoveryExecutor-30-thread-1-processing-n:127.0.0.1:38301_solr x:backuprestore_testbackupinc_restored_shard2_replica_n5 c:backuprestore_testbackupinc_restored s:shard2 r:core_node6) [n:127.0.0.1:38301_solr c:backuprestore_testbackupinc_restored s:shard2 r:core_node6 x:backuprestore_testbackupinc_restored_shard2_replica_n5] o.a.s.u.PeerSyncWithLeader no frame of reference to tell if we've missed updates
   [junit4]   2> 39201 WARN  (recoveryExecutor-30-thread-2-processing-n:127.0.0.1:38301_solr x:backuprestore_testbackupinc_restored_shard1_replica_n7 c:backuprestore_testbackupinc_restored s:shard1 r:core_node8) [n:127.0.0.1:38301_solr c:backuprestore_testbackupinc_restored s:shard1 r:core_node8 x:backuprestore_testbackupinc_restored_shard1_replica_n7] o.a.s.u.PeerSyncWithLeader no frame of reference to tell if we've missed updates
   [junit4]   2> 39709 WARN  (zkCallback-37-thread-3) [    ] o.a.s.c.LeaderElector Our node is no longer in line to be leader
   [junit4]   2> 59584 WARN  (zkCallback-35-thread-4) [    ] o.a.s.c.LeaderElector Our node is no longer in line to be leader
   [junit4]   2> 65198 WARN  (OverseerThreadFactory-48-thread-5-processing-n:127.0.0.1:35485_solr) [n:127.0.0.1:35485_solr c:backuprestore_testbackupinc_restored   ] o.a.s.c.a.c.CreateCollectionCmd It is unusual to create a collection (backuprestore_testbackupinc_restored) without cores.
   [junit4]   2> 67380 WARN  (recoveryExecutor-30-thread-2-processing-n:127.0.0.1:38301_solr x:backuprestore_testbackupinc_restored_shard2_replica_n5 c:backuprestore_testbackupinc_restored s:shard2 r:core_node6) [n:127.0.0.1:38301_solr c:backuprestore_testbackupinc_restored s:shard2 r:core_node6 x:backuprestore_testbackupinc_restored_shard2_replica_n5] o.a.s.u.PeerSyncWithLeader no frame of reference to tell if we've missed updates
   [junit4]   2> 67662 WARN  (recoveryExecutor-30-thread-1-processing-n:127.0.0.1:38301_solr x:backuprestore_testbackupinc_restored_shard1_replica_n7 c:backuprestore_testbackupinc_restored s:shard1 r:core_node8) [n:127.0.0.1:38301_solr c:backuprestore_testbackupinc_restored s:shard1 r:core_node8 x:backuprestore_testbackupinc_restored_shard1_replica_n7] o.a.s.u.PeerSyncWithLeader no frame of reference to tell if we've missed updates
   [junit4]   2> 70923 ERROR (OverseerThreadFactory-48-thread-5-processing-n:127.0.0.1:35485_solr) [n:127.0.0.1:35485_solr c:backuprestore_testbackupinc   ] o.a.s.c.a.c.OverseerCollectionMessageHandler Error from shard 127.0.0.1:35485_solr: {responseHeader={status=0,QTime=0},STATUS=failed,Response=Failed to backup core=backuprestore_testbackupinc_shard1_replica_n2 because org.apache.lucene.index.CorruptIndexException: checksum failed (hardware problem?) : expected=a676683d actual=9ab05b0a (resource=BufferedChecksumIndexInput(MMapIndexInput(path="/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/contrib/solr-s3-repository/test/J2/temp/solr.s3.S3IncrementalBackupTest_FAD08ED5C75C377F-001/tempDir-001/node1/backuprestore_testbackupinc_shard1_replica_n2/data/index/_i.fdm")))}
   [junit4]   2> 70924 ERROR (OverseerThreadFactory-48-thread-5-processing-n:127.0.0.1:35485_solr) [n:127.0.0.1:35485_solr c:backuprestore_testbackupinc   ] o.a.s.c.a.c.BackupCmd Error happened during incremental backup for collection: backuprestore_testbackupinc
   [junit4]   2> org.apache.solr.common.SolrException: Could not backup all shards
   [junit4]   2> 	at org.apache.solr.cloud.api.collections.BackupCmd.incrementalCopyIndexFiles(BackupCmd.java:254) ~[java/:?]
   [junit4]   2> 	at org.apache.solr.cloud.api.collections.BackupCmd.call(BackupCmd.java:105) ~[java/:?]
   [junit4]   2> 	at org.apache.solr.cloud.api.collections.OverseerCollectionMessageHandler.processMessage(OverseerCollectionMessageHandler.java:271) ~[java/:?]
   [junit4]   2> 	at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:524) ~[java/:?]
   [junit4]   2> 	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:218) ~[java/:?]
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_291]
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_291]
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:748) [?:1.8.0_291]
   [junit4]   2> 70995 ERROR (OverseerThreadFactory-48-thread-5-processing-n:127.0.0.1:35485_solr) [n:127.0.0.1:35485_solr c:backuprestore_testbackupinc   ] o.a.s.s.S3StorageClient An AmazonServiceException was thrown! [serviceName=S3] [awsRequestId=] [httpStatus=404] [s3ErrorCode=NoSuchKey] [message=The specified key does not exist.]
   [junit4]   2> 70996 ERROR (OverseerThreadFactory-48-thread-5-processing-n:127.0.0.1:35485_solr) [n:127.0.0.1:35485_solr c:backuprestore_testbackupinc   ] o.a.s.c.a.c.OverseerCollectionMessageHandler Collection: backuprestore_testbackupinc operation: backup failed:org.apache.solr.common.SolrException: Could not backup all shards
   [junit4]   2> 	at org.apache.solr.cloud.api.collections.BackupCmd.incrementalCopyIndexFiles(BackupCmd.java:254)
   [junit4]   2> 	at org.apache.solr.cloud.api.collections.BackupCmd.call(BackupCmd.java:105)
   [junit4]   2> 	at org.apache.solr.cloud.api.collections.OverseerCollectionMessageHandler.processMessage(OverseerCollectionMessageHandler.java:271)
   [junit4]   2> 	at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:524)
   [junit4]   2> 	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:218)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 
   [junit4]   2> 74724 ERROR (qtp1695573696-218) [    ] c.a.t.s.d.FileStore File can not be read
   [junit4]   2> com.fasterxml.jackson.databind.exc.MismatchedInputException: No content to map due to end-of-input
   [junit4]   2>  at [Source: (File); line: 1, column: 0]
   [junit4]   2> 	at com.fasterxml.jackson.databind.exc.MismatchedInputException.from(MismatchedInputException.java:59) ~[jackson-databind-2.12.3.jar:2.12.3]
   [junit4]   2> 	at com.fasterxml.jackson.databind.ObjectMapper._initForReading(ObjectMapper.java:4688) ~[jackson-databind-2.12.3.jar:2.12.3]
   [junit4]   2> 	at com.fasterxml.jackson.databind.ObjectMapper._readMapAndClose(ObjectMapper.java:4586) ~[jackson-databind-2.12.3.jar:2.12.3]
   [junit4]   2> 	at com.fasterxml.jackson.databind.ObjectMapper.readValue(ObjectMapper.java:3413) ~[jackson-databind-2.12.3.jar:2.12.3]
   [junit4]   2> 	at com.adobe.testing.s3mock.domain.FileStore.getS3Object(FileStore.java:510) ~[s3mock-2.1.34.jar:?]
   [junit4]   2> 	at com.adobe.testing.s3mock.FileStoreController.headObject(FileStoreController.java:257) ~[s3mock-2.1.34.jar:?]
   [junit4]   2> 	at sun.reflect.GeneratedMethodAccessor64.invoke(Unknown Source) ~[?:?]
   [junit4]   2> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_291]
   [junit4]   2> 	at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_291]
   [junit4]   2> 	at org.springframework.web.method.support.InvocableHandlerMethod.doInvoke(InvocableHandlerMethod.java:190) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.method.support.InvocableHandlerMethod.invokeForRequest(InvocableHandlerMethod.java:138) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.mvc.method.annotation.ServletInvocableHandlerMethod.invokeAndHandle(ServletInvocableHandlerMethod.java:105) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.invokeHandlerMethod(RequestMappingHandlerAdapter.java:878) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.handleInternal(RequestMappingHandlerAdapter.java:792) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.mvc.method.AbstractHandlerMethodAdapter.handle(AbstractHandlerMethodAdapter.java:87) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:1040) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:943) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:1006) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.FrameworkServlet.doGet(FrameworkServlet.java:898) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at javax.servlet.http.HttpServlet.doHead(HttpServlet.java:288) ~[javax.servlet-api-3.1.0.jar:3.1.0]
   [junit4]   2> 	at javax.servlet.http.HttpServlet.service(HttpServlet.java:704) ~[javax.servlet-api-3.1.0.jar:3.1.0]
   [junit4]   2> 	at org.springframework.web.servlet.FrameworkServlet.service(FrameworkServlet.java:883) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at javax.servlet.http.HttpServlet.service(HttpServlet.java:790) ~[javax.servlet-api-3.1.0.jar:3.1.0]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:799) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$ChainEnd.doFilter(ServletHandler.java:1626) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at com.adobe.testing.s3mock.KmsValidationFilter.doFilterInternal(KmsValidationFilter.java:91) ~[s3mock-2.1.34.jar:?]
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.springframework.web.filter.RequestContextFilter.doFilterInternal(RequestContextFilter.java:100) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:103) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.springframework.boot.actuate.metrics.web.servlet.WebMvcMetricsFilter.doFilterInternal(WebMvcMetricsFilter.java:97) ~[spring-boot-actuator-2.3.12.RELEASE.jar:2.3.12.RELEASE]
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.springframework.web.filter.CharacterEncodingFilter.doFilterInternal(CharacterEncodingFilter.java:201) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:548) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:602) ~[jetty-security-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:235) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1624) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1435) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:501) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1594) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1350) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.Server.handle(Server.java:516) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:388) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:633) [jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:380) [jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:277) [jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311) [jetty-io-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:105) [jetty-io-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.io.ChannelEndPoint$1.run(ChannelEndPoint.java:104) [jetty-io-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.runTask(EatWhatYouKill.java:336) [jetty-util-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:313) [jetty-util-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171) [jetty-util-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:129) [jetty-util-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:383) [jetty-util-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:882) [jetty-util-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:1036) [jetty-util-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:748) [?:1.8.0_291]
   [junit4]   2> com.fasterxml.jackson.databind.exc.MismatchedInputException: No content to map due to end-of-input
   [junit4]   2>  at [Source: (File); line: 1, column: 0]
   [junit4]   2> 	at com.fasterxml.jackson.databind.exc.MismatchedInputException.from(MismatchedInputException.java:59)
   [junit4]   2> 	at com.fasterxml.jackson.databind.ObjectMapper._initForReading(ObjectMapper.java:4688)
   [junit4]   2> 	at com.fasterxml.jackson.databind.ObjectMapper._readMapAndClose(ObjectMapper.java:4586)
   [junit4]   2> 	at com.fasterxml.jackson.databind.ObjectMapper.readValue(ObjectMapper.java:3413)
   [junit4]   2> 	at com.adobe.testing.s3mock.domain.FileStore.getS3Object(FileStore.java:510)
   [junit4]   2> 	at com.adobe.testing.s3mock.FileStoreController.headObject(FileStoreController.java:257)
   [junit4]   2> 	at sun.reflect.GeneratedMethodAccessor64.invoke(Unknown Source)
   [junit4]   2> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2> 	at java.lang.reflect.Method.invoke(Method.java:498)
   [junit4]   2> 	at org.springframework.web.method.support.InvocableHandlerMethod.doInvoke(InvocableHandlerMethod.java:190)
   [junit4]   2> 	at org.springframework.web.method.support.InvocableHandlerMethod.invokeForRequest(InvocableHandlerMethod.java:138)
   [junit4]   2> 	at org.springframework.web.servlet.mvc.method.annotation.ServletInvocableHandlerMethod.invokeAndHandle(ServletInvocableHandlerMethod.java:105)
   [junit4]   2> 	at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.invokeHandlerMethod(RequestMappingHandlerAdapter.java:878)
   [junit4]   2> 	at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.handleInternal(RequestMappingHandlerAdapter.java:792)
   [junit4]   2> 	at org.springframework.web.servlet.mvc.method.AbstractHandlerMethodAdapter.handle(AbstractHandlerMethodAdapter.java:87)
   [junit4]   2> 	at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:1040)
   [junit4]   2> 	at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:943)
   [junit4]   2> 	at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:1006)
   [junit4]   2> 	at org.springframework.web.servlet.FrameworkServlet.doGet(FrameworkServlet.java:898)
   [junit4]   2> 	at javax.servlet.http.HttpServlet.doHead(HttpServlet.java:288)
   [junit4]   2> 	at javax.servlet.http.HttpServlet.service(HttpServlet.java:704)
   [junit4]   2> 	at org.springframework.web.servlet.FrameworkServlet.service(FrameworkServlet.java:883)
   [junit4]   2> 	at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:799)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$ChainEnd.doFilter(ServletHandler.java:1626)
   [junit4]   2> 	at com.adobe.testing.s3mock.KmsValidationFilter.doFilterInternal(KmsValidationFilter.java:91)
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119)
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601)
   [junit4]   2> 	at org.springframework.web.filter.RequestContextFilter.doFilterInternal(RequestContextFilter.java:100)
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119)
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601)
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:103)
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601)
   [junit4]   2> 	at org.springframework.boot.actuate.metrics.web.servlet.WebMvcMetricsFilter.doFilterInternal(WebMvcMetricsFilter.java:97)
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119)
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601)
   [junit4]   2> 	at org.springframework.web.filter.CharacterEncodingFilter.doFilterInternal(CharacterEncodingFilter.java:201)
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119)
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:548)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
   [junit4]   2> 	at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:602)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:235)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1624)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1435)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:501)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1594)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1350)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
   [junit4]   2> 	at org.eclipse.jetty.server.Server.handle(Server.java:516)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:388)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:633)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:380)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:277)
   [junit4]   2> 	at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311)
   [junit4]   2> 	at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:105)
   [junit4]   2> 	at org.eclipse.jetty.io.ChannelEndPoint$1.run(ChannelEndPoint.java:104)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.runTask(EatWhatYouKill.java:336)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:313)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:129)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:383)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:882)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:1036)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 74730 ERROR (qtp1695573696-296) [    ] c.a.t.s.d.FileStore File can not be read
   [junit4]   2> com.fasterxml.jackson.databind.exc.MismatchedInputException: No content to map due to end-of-input
   [junit4]   2>  at [Source: (File); line: 1, column: 0]
   [junit4]   2> 	at com.fasterxml.jackson.databind.exc.MismatchedInputException.from(MismatchedInputException.java:59) ~[jackson-databind-2.12.3.jar:2.12.3]
   [junit4]   2> 	at com.fasterxml.jackson.databind.ObjectMapper._initForReading(ObjectMapper.java:4688) ~[jackson-databind-2.12.3.jar:2.12.3]
   [junit4]   2> 	at com.fasterxml.jackson.databind.ObjectMapper._readMapAndClose(ObjectMapper.java:4586) ~[jackson-databind-2.12.3.jar:2.12.3]
   [junit4]   2> 	at com.fasterxml.jackson.databind.ObjectMapper.readValue(ObjectMapper.java:3413) ~[jackson-databind-2.12.3.jar:2.12.3]
   [junit4]   2> 	at com.adobe.testing.s3mock.domain.FileStore.getS3Object(FileStore.java:510) ~[s3mock-2.1.34.jar:?]
   [junit4]   2> 	at com.adobe.testing.s3mock.FileStoreController.headObject(FileStoreController.java:257) ~[s3mock-2.1.34.jar:?]
   [junit4]   2> 	at sun.reflect.GeneratedMethodAccessor64.invoke(Unknown Source) ~[?:?]
   [junit4]   2> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_291]
   [junit4]   2> 	at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_291]
   [junit4]   2> 	at org.springframework.web.method.support.InvocableHandlerMethod.doInvoke(InvocableHandlerMethod.java:190) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.method.support.InvocableHandlerMethod.invokeForRequest(InvocableHandlerMethod.java:138) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.mvc.method.annotation.ServletInvocableHandlerMethod.invokeAndHandle(ServletInvocableHandlerMethod.java:105) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.invokeHandlerMethod(RequestMappingHandlerAdapter.java:878) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.handleInternal(RequestMappingHandlerAdapter.java:792) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.mvc.method.AbstractHandlerMethodAdapter.handle(AbstractHandlerMethodAdapter.java:87) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:1040) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:943) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:1006) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.FrameworkServlet.doGet(FrameworkServlet.java:898) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at javax.servlet.http.HttpServlet.doHead(HttpServlet.java:288) ~[javax.servlet-api-3.1.0.jar:3.1.0]
   [junit4]   2> 	at javax.servlet.http.HttpServlet.service(HttpServlet.java:704) ~[javax.servlet-api-3.1.0.jar:3.1.0]
   [junit4]   2> 	at org.springframework.web.servlet.FrameworkServlet.service(FrameworkServlet.java:883) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at javax.servlet.http.HttpServlet.service(HttpServlet.java:790) ~[javax.servlet-api-3.1.0.jar:3.1.0]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:799) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$ChainEnd.doFilter(ServletHandler.java:1626) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at com.adobe.testing.s3mock.KmsValidationFilter.doFilterInternal(KmsValidationFilter.java:91) ~[s3mock-2.1.34.jar:?]
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.springframework.web.filter.RequestContextFilter.doFilterInternal(RequestContextFilter.java:100) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:103) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.springframework.boot.actuate.metrics.web.servlet.WebMvcMetricsFilter.doFilterInternal(WebMvcMetricsFilter.java:97) ~[spring-boot-actuator-2.3.12.RELEASE.jar:2.3.12.RELEASE]
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.springframework.web.filter.CharacterEncodingFilter.doFilterInternal(CharacterEncodingFilter.java:201) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:548) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:602) ~[jetty-security-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:235) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1624) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1435) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:501) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1594) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1350) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.Server.handle(Server.java:516) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:388) ~[jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:633) [jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:380) [jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:277) [jetty-server-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311) [jetty-io-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:105) [jetty-io-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.io.ChannelEndPoint$1.run(ChannelEndPoint.java:104) [jetty-io-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.runTask(EatWhatYouKill.java:336) [jetty-util-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:313) [jetty-util-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171) [jetty-util-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:129) [jetty-util-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:383) [jetty-util-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:882) [jetty-util-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:1036) [jetty-util-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:748) [?:1.8.0_291]
   [junit4]   2> com.fasterxml.jackson.databind.exc.MismatchedInputException: No content to map due to end-of-input
   [junit4]   2>  at [Source: (File); line: 1, column: 0]
   [junit4]   2> 	at com.fasterxml.jackson.databind.exc.MismatchedInputException.from(MismatchedInputException.java:59)
   [junit4]   2> 	at com.fasterxml.jackson.databind.ObjectMapper._initForReading(ObjectMapper.java:4688)
   [junit4]   2> 	at com.fasterxml.jackson.databind.ObjectMapper._readMapAndClose(ObjectMapper.java:4586)
   [junit4]   2> 	at com.fasterxml.jackson.databind.ObjectMapper.readValue(ObjectMapper.java:3413)
   [junit4]   2> 	at com.adobe.testing.s3mock.domain.FileStore.getS3Object(FileStore.java:510)
   [junit4]   2> 	at com.adobe.testing.s3mock.FileStoreController.headObject(FileStoreController.java:257)
   [junit4]   2> 	at sun.reflect.GeneratedMethodAccessor64.invoke(Unknown Source)
   [junit4]   2> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2> 	at java.lang.reflect.Method.invoke(Method.java:498)
   [junit4]   2> 	at org.springframework.web.method.support.InvocableHandlerMethod.doInvoke(InvocableHandlerMethod.java:190)
   [junit4]   2> 	at org.springframework.web.method.support.InvocableHandlerMethod.invokeForRequest(InvocableHandlerMethod.java:138)
   [junit4]   2> 	at org.springframework.web.servlet.mvc.method.annotation.ServletInvocableHandlerMethod.invokeAndHandle(ServletInvocableHandlerMethod.java:105)
   [junit4]   2> 	at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.invokeHandlerMethod(RequestMappingHandlerAdapter.java:878)
   [junit4]   2> 	at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.handleInternal(RequestMappingHandlerAdapter.java:792)
   [junit4]   2> 	at org.springframework.web.servlet.mvc.method.AbstractHandlerMethodAdapter.handle(AbstractHandlerMethodAdapter.java:87)
   [junit4]   2> 	at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:1040)
   [junit4]   2> 	at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:943)
   [junit4]   2> 	at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:1006)
   [junit4]   2> 	at org.springframework.web.servlet.FrameworkServlet.doGet(FrameworkServlet.java:898)
   [junit4]   2> 	at javax.servlet.http.HttpServlet.doHead(HttpServlet.java:288)
   [junit4]   2> 	at javax.servlet.http.HttpServlet.service(HttpServlet.java:704)
   [junit4]   2> 	at org.springframework.web.servlet.FrameworkServlet.service(FrameworkServlet.java:883)
   [junit4]   2> 	at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:799)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$ChainEnd.doFilter(ServletHandler.java:1626)
   [junit4]   2> 	at com.adobe.testing.s3mock.KmsValidationFilter.doFilterInternal(KmsValidationFilter.java:91)
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119)
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601)
   [junit4]   2> 	at org.springframework.web.filter.RequestContextFilter.doFilterInternal(RequestContextFilter.java:100)
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119)
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601)
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:103)
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601)
   [junit4]   2> 	at org.springframework.boot.actuate.metrics.web.servlet.WebMvcMetricsFilter.doFilterInternal(WebMvcMetricsFilter.java:97)
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119)
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601)
   [junit4]   2> 	at org.springframework.web.filter.CharacterEncodingFilter.doFilterInternal(CharacterEncodingFilter.java:201)
   [junit4]   2> 	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119)
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:193)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1601)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:548)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
   [junit4]   2> 	at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:602)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:235)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1624)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1435)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:501)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1594)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1350)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127)
   [junit4]   2> 	at org.eclipse.jetty.server.Server.handle(Server.java:516)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:388)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:633)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:380)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:277)
   [junit4]   2> 	at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311)
   [junit4]   2> 	at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:105)
   [junit4]   2> 	at org.eclipse.jetty.io.ChannelEndPoint$1.run(ChannelEndPoint.java:104)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.runTask(EatWhatYouKill.java:336)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:313)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:129)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:383)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:882)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:1036)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 75223 ERROR (OverseerThreadFactory-48-thread-5-processing-n:127.0.0.1:35485_solr) [n:127.0.0.1:35485_solr c:backuprestore_testbackuprestoretooriginal   ] o.a.s.c.a.c.OverseerCollectionMessageHandler Error from shard 127.0.0.1:38301_solr: {responseHeader={status=0,QTime=0},STATUS=failed,Response=Failed to backup core=backuprestore_testbackuprestoretooriginal_shard2_replica_n4 because org.apache.solr.s3.S3Exception: Parent directory doesn't exist of path: mytestbackuptestbackuprestoretooriginal/backuprestore_testbackuprestoretooriginal/index/413ff03f-fe61-4c85-97e0-ef0c24b7aeaa}
   [junit4]   2> 75225 ERROR (OverseerThreadFactory-48-thread-5-processing-n:127.0.0.1:35485_solr) [n:127.0.0.1:35485_solr c:backuprestore_testbackuprestoretooriginal   ] o.a.s.c.a.c.BackupCmd Error happened during incremental backup for collection: backuprestore_testbackuprestoretooriginal
   [junit4]   2> org.apache.solr.common.SolrException: Could not backup all shards
   [junit4]   2> 	at org.apache.solr.cloud.api.collections.BackupCmd.incrementalCopyIndexFiles(BackupCmd.java:254) ~[java/:?]
   [junit4]   2> 	at org.apache.solr.cloud.api.collections.BackupCmd.call(BackupCmd.java:105) ~[java/:?]
   [junit4]   2> 	at org.apache.solr.cloud.api.collections.OverseerCollectionMessageHandler.processMessage(OverseerCollectionMessageHandler.java:271) ~[java/:?]
   [junit4]   2> 	at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:524) ~[java/:?]
   [junit4]   2> 	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:218) ~[java/:?]
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_291]
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_291]
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:748) [?:1.8.0_291]
   [junit4]   2> 75302 ERROR (OverseerThreadFactory-48-thread-5-processing-n:127.0.0.1:35485_solr) [n:127.0.0.1:35485_solr c:backuprestore_testbackuprestoretooriginal   ] o.a.s.s.S3StorageClient An AmazonServiceException was thrown! [serviceName=S3] [awsRequestId=] [httpStatus=404] [s3ErrorCode=NoSuchKey] [message=The specified key does not exist.]
   [junit4]   2> 75303 ERROR (OverseerThreadFactory-48-thread-5-processing-n:127.0.0.1:35485_solr) [n:127.0.0.1:35485_solr c:backuprestore_testbackuprestoretooriginal   ] o.a.s.c.a.c.OverseerCollectionMessageHandler Collection: backuprestore_testbackuprestoretooriginal operation: backup failed:org.apache.solr.common.SolrException: Could not backup all shards
   [junit4]   2> 	at org.apache.solr.cloud.api.collections.BackupCmd.incrementalCopyIndexFiles(BackupCmd.java:254)
   [junit4]   2> 	at org.apache.solr.cloud.api.collections.BackupCmd.call(BackupCmd.java:105)
   [junit4]   2> 	at org.apache.solr.cloud.api.collections.OverseerCollectionMessageHandler.processMessage(OverseerCollectionMessageHandler.java:271)
   [junit4]   2> 	at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:524)
   [junit4]   2> 	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:218)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 
   [junit4]   2> NOTE: download the large Jenkins line-docs file by running 'ant get-jenkins-line-docs' in the lucene directory.
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=S3IncrementalBackupTest -Dtests.method=testRestoreToOriginalCollection -Dtests.seed=FAD08ED5C75C377F -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.badapples=true -Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/test-data/enwiki.random.lines.txt -Dtests.locale=sq-AL -Dtests.timezone=America/Cayman -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
   [junit4] FAILURE 4.31s J2 | S3IncrementalBackupTest.testRestoreToOriginalCollection <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: expected:<COMPLETED> but was:<FAILED>
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([FAD08ED5C75C377F:CF24658E2C800121]:0)
   [junit4]    > 	at org.apache.solr.cloud.api.collections.AbstractIncrementalBackupTest.testRestoreToOriginalCollection(AbstractIncrementalBackupTest.java:201)
   [junit4]    > 	at com.adobe.testing.s3mock.junit4.S3MockRule$1.evaluate(S3MockRule.java:66)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 80437 ERROR (qtp1695573696-397) [    ] c.a.t.s.d.FileStore File can not be read
   [junit4]   2> com.fasterxml.jackson.databind.exc.MismatchedInputException: No content to map due to end-of-input
   [junit4]   2>  at [Source: (File); line: 1, column: 0]
   [junit4]   2> 	at com.fasterxml.jackson.databind.exc.MismatchedInputException.from(MismatchedInputException.java:59) ~[jackson-databind-2.12.3.jar:2.12.3]
   [junit4]   2> 	at com.fasterxml.jackson.databind.ObjectMapper._initForReading(ObjectMapper.java:4688) ~[jackson-databind-2.12.3.jar:2.12.3]
   [junit4]   2> 	at com.fasterxml.jackson.databind.ObjectMapper._readMapAndClose(ObjectMapper.java:4586) ~[jackson-databind-2.12.3.jar:2.12.3]
   [junit4]   2> 	at com.fasterxml.jackson.databind.ObjectMapper.readValue(ObjectMapper.java:3413) ~[jackson-databind-2.12.3.jar:2.12.3]
   [junit4]   2> 	at com.adobe.testing.s3mock.domain.FileStore.getS3Object(FileStore.java:510) ~[s3mock-2.1.34.jar:?]
   [junit4]   2> 	at com.adobe.testing.s3mock.FileStoreController.headObject(FileStoreController.java:257) ~[s3mock-2.1.34.jar:?]
   [junit4]   2> 	at sun.reflect.GeneratedMethodAccessor64.invoke(Unknown Source) ~[?:?]
   [junit4]   2> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_291]
   [junit4]   2> 	at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_291]
   [junit4]   2> 	at org.springframework.web.method.support.InvocableHandlerMethod.doInvoke(InvocableHandlerMethod.java:190) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.method.support.InvocableHandlerMethod.invokeForRequest(InvocableHandlerMethod.java:138) ~[spring-web-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.mvc.method.annotation.ServletInvocableHandlerMethod.invokeAndHandle(ServletInvocableHandlerMethod.java:105) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.invokeHandlerMethod(RequestMappingHandlerAdapter.java:878) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.handleInternal(RequestMappingHandlerAdapter.java:792) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.mvc.method.AbstractHandlerMethodAdapter.handle(AbstractHandlerMethodAdapter.java:87) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:1040) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:943) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:1006) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at org.springframework.web.servlet.FrameworkServlet.doGet(FrameworkServlet.java:898) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at javax.servlet.http.HttpServlet.doHead(HttpServlet.java:288) ~[javax.servlet-api-3.1.0.jar:3.1.0]
   [junit4]   2> 	at javax.servlet.http.HttpServlet.service(HttpServlet.java:704) ~[javax.servlet-api-3.1.0.jar:3.1.0]
   [junit4]   2> 	at org.springframework.web.servlet.FrameworkServlet.service(FrameworkServlet.java:883) ~[spring-webmvc-5.2.15.RELEASE.jar:5.2.15.RELEASE]
   [junit4]   2> 	at javax.servlet.http.HttpServlet.service(HttpServlet.java:790) ~[javax.servlet-api-3.1.0.jar:3.1.0]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:799) ~[jetty-servlet-9.4.41.v20210516.jar:9.4.41.v20210516]
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHa

[...truncated too long message...]

n(Thread.java:748) [?:1.8.0_291]
   [junit4]   2> 81300 ERROR (OverseerThreadFactory-48-thread-5-processing-n:127.0.0.1:35485_solr) [n:127.0.0.1:35485_solr c:backuprestore_testbackupincsimple   ] o.a.s.s.S3StorageClient An AmazonServiceException was thrown! [serviceName=S3] [awsRequestId=] [httpStatus=404] [s3ErrorCode=NoSuchKey] [message=The specified key does not exist.]
   [junit4]   2> 81302 ERROR (OverseerThreadFactory-48-thread-5-processing-n:127.0.0.1:35485_solr) [n:127.0.0.1:35485_solr c:backuprestore_testbackupincsimple   ] o.a.s.c.a.c.OverseerCollectionMessageHandler Collection: backuprestore_testbackupincsimple operation: backup failed:org.apache.solr.common.SolrException: Could not backup all shards
   [junit4]   2> 	at org.apache.solr.cloud.api.collections.BackupCmd.incrementalCopyIndexFiles(BackupCmd.java:254)
   [junit4]   2> 	at org.apache.solr.cloud.api.collections.BackupCmd.call(BackupCmd.java:105)
   [junit4]   2> 	at org.apache.solr.cloud.api.collections.OverseerCollectionMessageHandler.processMessage(OverseerCollectionMessageHandler.java:271)
   [junit4]   2> 	at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:524)
   [junit4]   2> 	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:218)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 
   [junit4]   2> 82268 WARN  (OverseerThreadFactory-48-thread-5-processing-n:127.0.0.1:35485_solr) [n:127.0.0.1:35485_solr c:backuprestore_testbackupincsimple_restore   ] o.a.s.c.a.c.CreateCollectionCmd It is unusual to create a collection (backuprestore_testbackupincsimple_restore) without cores.
   [junit4]   2> 86510 WARN  (jetty-launcher-8-thread-2-SendThread(127.0.0.1:38913)) [    ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10163a991960008.
   [junit4]   2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x10163a991960008, likely server has closed socket
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 86514 WARN  (jetty-launcher-8-thread-1-SendThread(127.0.0.1:38913)) [    ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10163a991960007.
   [junit4]   2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x10163a991960007, likely server has closed socket
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 86615 INFO  (jetty-closer-256-thread-2-processing-n:127.0.0.1:35485_solr) [    ] o.e.j.s.AbstractConnector Stopped ServerConnector@543e45f5{SSL, (ssl, http/1.1)}{127.0.0.1:0}
   [junit4]   2> 86616 INFO  (jetty-closer-256-thread-1-processing-n:127.0.0.1:35485_solr) [    ] o.e.j.s.AbstractConnector Stopped ServerConnector@57cc44a5{SSL, (ssl, http/1.1)}{127.0.0.1:0}
   [junit4]   2> 86618 INFO  (jetty-closer-256-thread-2-processing-n:127.0.0.1:35485_solr) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@693c4822{/solr,null,STOPPED}
   [junit4]   2> 86618 INFO  (jetty-closer-256-thread-1-processing-n:127.0.0.1:35485_solr) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5a24da24{/solr,null,STOPPED}
   [junit4]   2> 86618 INFO  (jetty-closer-256-thread-1-processing-n:127.0.0.1:35485_solr) [    ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 86618 INFO  (jetty-closer-256-thread-2-processing-n:127.0.0.1:35485_solr) [    ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 86825 WARN  (ZkTestServer Run Thread) [    ] o.a.s.c.ZkTestServer Watch limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2> 	36	/solr/collections/backuprestore_testbackupinc_restored/terms/shard1
   [junit4]   2> 	35	/solr/collections/backuprestore_testbackupinc_restored/terms/shard2
   [junit4]   2> 	26	/solr/collections/backuprestore_testbackupinc_restored/state.json
   [junit4]   2> 	7	/solr/collections/backuprestore_testbackuprestoretooriginal/terms/shard2
   [junit4]   2> 	7	/solr/collections/backuprestore_testbackuprestoretooriginal/terms/shard1
   [junit4]   2> 	7	/solr/collections/backuprestore_testbackupinc/terms/shard1
   [junit4]   2> 	6	/solr/collections/backuprestore_testbackupinc/terms/shard2
   [junit4]   2> 	3	/solr/collections/backuprestore_testbackupincsimple_restore/terms/shard2
   [junit4]   2> 	3	/solr/aliases.json
   [junit4]   2> 	3	/solr/collections/backuprestore_testbackupincsimple_restore/terms/shard1
   [junit4]   2> 	3	/solr/collections/backuprestore_testbackupincsimple/terms/shard2
   [junit4]   2> 	3	/solr/collections/backuprestore_testbackupincsimple/terms/shard1
   [junit4]   2> 	2	/solr/packages.json
   [junit4]   2> 	2	/solr/collections/backuprestore_testbackupinc_restored/collectionprops.json
   [junit4]   2> 	2	/solr/security.json
   [junit4]   2> 	2	/solr/collections/backuprestore_testbackupincsimple/collectionprops.json
   [junit4]   2> 	2	/solr/configs/conf1
   [junit4]   2> 	2	/solr/collections/backuprestore_testbackuprestoretooriginal/collectionprops.json
   [junit4]   2> 	2	/solr/collections/backuprestore_testbackupinc/collectionprops.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2> 	154	/solr/collections/backuprestore_testbackupinc_restored/state.json
   [junit4]   2> 	50	/solr/collections/backuprestore_testbackupincsimple_restore/state.json
   [junit4]   2> 	30	/solr/collections/backuprestore_testbackupincsimple/state.json
   [junit4]   2> 	25	/solr/collections/backuprestore_testbackuprestoretooriginal/state.json
   [junit4]   2> 	22	/solr/collections/backuprestore_testbackupinc/state.json
   [junit4]   2> 	3	/solr/clusterprops.json
   [junit4]   2> 	3	/solr/clusterstate.json
   [junit4]   2> 	2	/solr/collections/backuprestore_testbackupinc_restored/leader_elect/shard2/election/72448648957788167-core_node2-n_0000000000
   [junit4]   2> 	2	/solr/collections/backuprestore_testbackupinc_restored/leader_elect/shard1/election/72448648957788167-core_node4-n_0000000000
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2> 	181	/solr/overseer/queue
   [junit4]   2> 	72	/solr/overseer/collection-queue-work
   [junit4]   2> 	33	/solr/collections
   [junit4]   2> 	30	/solr/collections/backuprestore_testbackupinc_restored/state.json
   [junit4]   2> 	11	/solr/collections/backuprestore_testbackuprestoretooriginal/state.json
   [junit4]   2> 	9	/solr/collections/backuprestore_testbackupinc/state.json
   [junit4]   2> 	8	/solr/collections/backuprestore_testbackupincsimple/state.json
   [junit4]   2> 	8	/solr/collections/backuprestore_testbackupincsimple_restore/state.json
   [junit4]   2> 	7	/solr/live_nodes
   [junit4]   2> 
   [junit4]   2> 86847 INFO  (SUITE-S3IncrementalBackupTest-seed#[FAD08ED5C75C377F]-worker) [n:127.0.0.1:35485_solr    ] o.e.j.s.AbstractConnector Stopped SslValidatingServerConnector@16d45ab2{SSL, (ssl, http/1.1)}{0.0.0.0:0}
   [junit4]   2> 86848 INFO  (SUITE-S3IncrementalBackupTest-seed#[FAD08ED5C75C377F]-worker) [n:127.0.0.1:35485_solr    ] o.e.j.s.AbstractConnector Stopped ServerConnector@4b82d098{HTTP/1.1, (http/1.1)}{0.0.0.0:0}
   [junit4]   2> 86848 INFO  (SUITE-S3IncrementalBackupTest-seed#[FAD08ED5C75C377F]-worker) [n:127.0.0.1:35485_solr    ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 86849 INFO  (SUITE-S3IncrementalBackupTest-seed#[FAD08ED5C75C377F]-worker) [n:127.0.0.1:35485_solr    ] o.e.j.s.h.C.application Destroying Spring FrameworkServlet 'dispatcherServlet'
   [junit4]   2> 86849 INFO  (SUITE-S3IncrementalBackupTest-seed#[FAD08ED5C75C377F]-worker) [n:127.0.0.1:35485_solr    ] o.e.j.s.h.ContextHandler Stopped o.s.b.w.e.j.JettyEmbeddedWebAppContext@6c72a9ba{application,/,[file:///home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/contrib/solr-s3-repository/test/J2/temp/jetty-docbase.0.5175493132766708912/],STOPPED}
   [junit4]   2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-NightlyTests-8.x/checkout/solr/build/contrib/solr-s3-repository/test/J2/temp/solr.s3.S3IncrementalBackupTest_FAD08ED5C75C377F-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene87): {shard_s=PostingsFormat(name=Direct), _root_=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), id=PostingsFormat(name=LuceneVarGapDocFreqInterval)}, docValues:{_version_=DocValuesFormat(name=Direct)}, maxPointsInLeafNode=1112, maxMBSortInHeap=5.150919966952349, sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=sq-AL, timezone=America/Cayman
   [junit4]   2> NOTE: Linux 4.15.0-147-generic amd64/Oracle Corporation 1.8.0_291 (64-bit)/cpus=4,threads=1,free=116001848,total=499122176
   [junit4]   2> NOTE: All tests run in this JVM: [S3IncrementalBackupTest]
   [junit4] Completed [7/7 (1!)] on J2 in 87.29s, 3 tests, 1 failure <<< FAILURES!

[...truncated 44691 lines...]