Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Linux/262/
Java: 64bit/jdk-12-ea+shipilev-fastdebug -XX:-UseCompressedOops -XX:+UseG1GC

2 tests failed.
FAILED:  org.apache.solr.metrics.rrd.SolrRrdBackendFactoryTest.testBasic

Error Message:
{} expected:<1> but was:<0>

Stack Trace:
java.lang.AssertionError: {} expected:<1> but was:<0>
        at 
__randomizedtesting.SeedInfo.seed([EC9EA956AD21863D:4764B44372FD0013]:0)
        at org.junit.Assert.fail(Assert.java:88)
        at org.junit.Assert.failNotEquals(Assert.java:834)
        at org.junit.Assert.assertEquals(Assert.java:645)
        at 
org.apache.solr.metrics.rrd.SolrRrdBackendFactoryTest.testBasic(SolrRrdBackendFactoryTest.java:92)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:567)
        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.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java: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.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 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.base/java.lang.Thread.run(Thread.java:835)


FAILED:  
org.apache.solr.security.hadoop.TestDelegationWithHadoopAuth.testDelegationTokenRenew

Error Message:
expected:<200> but was:<403>

Stack Trace:
java.lang.AssertionError: expected:<200> but was:<403>
        at 
__randomizedtesting.SeedInfo.seed([EC9EA956AD21863D:DB055D4895ED5B99]:0)
        at org.junit.Assert.fail(Assert.java:88)
        at org.junit.Assert.failNotEquals(Assert.java:834)
        at org.junit.Assert.assertEquals(Assert.java:645)
        at org.junit.Assert.assertEquals(Assert.java:631)
        at 
org.apache.solr.security.hadoop.TestDelegationWithHadoopAuth.renewDelegationToken(TestDelegationWithHadoopAuth.java:120)
        at 
org.apache.solr.security.hadoop.TestDelegationWithHadoopAuth.verifyDelegationTokenRenew(TestDelegationWithHadoopAuth.java:303)
        at 
org.apache.solr.security.hadoop.TestDelegationWithHadoopAuth.testDelegationTokenRenew(TestDelegationWithHadoopAuth.java:321)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:567)
        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.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java: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.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 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.base/java.lang.Thread.run(Thread.java:835)




Build Log:
[...truncated 14915 lines...]
   [junit4] Suite: org.apache.solr.metrics.rrd.SolrRrdBackendFactoryTest
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.metrics.rrd.SolrRrdBackendFactoryTest_EC9EA956AD21863D-001/init-core-data-001
   [junit4]   2> 3354063 WARN  
(SUITE-SolrRrdBackendFactoryTest-seed#[EC9EA956AD21863D]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=4 numCloses=4
   [junit4]   2> 3354063 INFO  
(SUITE-SolrRrdBackendFactoryTest-seed#[EC9EA956AD21863D]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 3354064 INFO  
(SUITE-SolrRrdBackendFactoryTest-seed#[EC9EA956AD21863D]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 3354064 INFO  
(SUITE-SolrRrdBackendFactoryTest-seed#[EC9EA956AD21863D]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 3354068 INFO  
(TEST-SolrRrdBackendFactoryTest.testBasic-seed#[EC9EA956AD21863D]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testBasic
   [junit4]   2> 3354153 INFO  
(TEST-SolrRrdBackendFactoryTest.testBasic-seed#[EC9EA956AD21863D]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testBasic
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=SolrRrdBackendFactoryTest -Dtests.method=testBasic 
-Dtests.seed=EC9EA956AD21863D -Dtests.multiplier=3 -Dtests.slow=true 
-Dtests.locale=it-CH -Dtests.timezone=Asia/Seoul -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1
   [junit4] FAILURE 0.16s J1 | SolrRrdBackendFactoryTest.testBasic <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: {} expected:<1> but 
was:<0>
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([EC9EA956AD21863D:4764B44372FD0013]:0)
   [junit4]    >        at 
org.apache.solr.metrics.rrd.SolrRrdBackendFactoryTest.testBasic(SolrRrdBackendFactoryTest.java:92)
   [junit4]    >        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]    >        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]    >        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]    >        at 
java.base/java.lang.reflect.Method.invoke(Method.java:567)
   [junit4]    >        at java.base/java.lang.Thread.run(Thread.java:835)
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.metrics.rrd.SolrRrdBackendFactoryTest_EC9EA956AD21863D-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene80), 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@ce57d2a),
 locale=it-CH, timezone=Asia/Seoul
   [junit4]   2> NOTE: Linux 4.18.0-15-generic amd64/Aleksey Shipilev 
12-testing (64-bit)/cpus=8,threads=1,free=253432200,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: 
[TestPartialUpdateDeduplication, PropertiesRequestHandlerTest, 
RegexBoostProcessorTest, TriggerSetPropertiesIntegrationTest, 
URLClassifyProcessorTest, TestSafeXMLParsing, 
SignatureUpdateProcessorFactoryTest, TestSQLHandlerNonCloud, 
TriLevelCompositeIdRoutingTest, TestFieldResource, TestRandomFaceting, 
TestCoreDiscovery, HighlighterConfigTest, MultiThreadedOCPTest, 
HdfsSyncSliceTest, TestRandomCollapseQParserPlugin, PeerSyncWithLeaderTest, 
HLLUtilTest, AutoScalingHandlerTest, ScheduledTriggerIntegrationTest, 
TestAuthenticationFramework, TestLFUCache, UninvertDocValuesMergePolicyTest, 
TestBM25SimilarityFactory, TestMaxTokenLenTokenizer, 
QueryElevationComponentTest, OverseerRolesTest, ProtectedTermFilterFactoryTest, 
TestDownShardTolerantSearch, TestRemoteStreaming, TestMultiWordSynonyms, 
CollectionsAPIAsyncDistributedZkTest, TestManagedStopFilterFactory, 
BlockDirectoryTest, AutoscalingHistoryHandlerTest, InfoHandlerTest, 
TestSolrFieldCacheBean, ExternalFileFieldSortTest, UpdateParamsTest, 
TestFieldCache, TestNRTOpen, CloudExitableDirectoryReaderTest, 
SignificantTermsQParserPluginTest, TestSubQueryTransformerDistrib, 
TestAddFieldRealTimeGet, FieldAnalysisRequestHandlerTest, DeleteShardTest, 
TestUpdate, LeaderFailoverAfterPartitionTest, TestSimNodeAddedTrigger, 
TestRealTimeGet, TestCloudSearcherWarming, NodeAddedTriggerTest, 
TestJsonFacets, TestFileDictionaryLookup, TestEmbeddedSolrServerConstructors, 
ShardRoutingCustomTest, TemplateUpdateProcessorTest, 
TestComplexPhraseQParserPlugin, HttpPartitionOnCommitTest, 
SolrCloudReportersTest, TestFacetMethods, SearchHandlerTest, 
SolrRequestParserTest, TestSizeLimitedDistributedMap, BJQParserTest, 
TestQueryTypes, TriggerCooldownIntegrationTest, 
ChaosMonkeySafeLeaderWithPullReplicasTest, TestHighlightDedupGrouping, 
ForceLeaderWithTlogReplicasTest, BasicAuthIntegrationTest, QueryParsingTest, 
TestLeaderElectionWithEmptyReplica, TestNumericRangeQuery32, 
TestCollationField, OverseerTest, TestChildDocTransformerHierarchy, 
TestFieldCacheSortRandom, BlockJoinFacetSimpleTest, 
HdfsChaosMonkeyNothingIsSafeTest, DistributedFacetSimpleRefinementLongTailTest, 
TestHttpShardHandlerFactory, SliceStateTest, CustomCollectionTest, 
TestCloudPseudoReturnFields, TestZkAclsWithHadoopAuth, TestSolrConfigHandler, 
RollingRestartTest, MinimalSchemaTest, TestPullReplica, 
HdfsAutoAddReplicasIntegrationTest, TestDirectoryFactory, 
TestTolerantUpdateProcessorCloud, NumberUtilsTest, 
TestSuggestSpellingConverter, TestStressRecovery, ChangedSchemaMergeTest, 
HttpSolrCallGetCoreTest, DistributedFacetPivotSmallTest, 
HdfsDirectoryFactoryTest, TestFastLRUCache, CollectionPropsTest, 
ByteBuffersDirectoryFactoryTest, SpatialRPTFieldTypeTest, SortByFunctionTest, 
CreateCollectionCleanupTest, TestCloudJSONFacetJoinDomain, 
TestRequestStatusCollectionAPI, FacetPivotSmallTest, 
TestImplicitCoreProperties, SolrIndexSplitterTest, TestSort, SearchHandlerTest, 
TestWithCollection, TestClusterStateMutator, TestDistributedSearch, 
TestCursorMarkWithoutUniqueKey, TestPushWriter, 
TestHighFrequencyDictionaryFactory, MoveReplicaHDFSTest, 
SpellCheckCollatorWithCollapseTest, TestRandomRequestDistribution, 
BasicFunctionalityTest, SOLR749Test, TestPKIAuthenticationPlugin, 
TestSchemaVersionResource, TestReqParamsAPI, CoreSorterTest, 
TestPerFieldSimilarity, HdfsRecoverLeaseTest, TestHdfsCloudBackupRestore, 
TestMiniSolrCloudClusterSSL, PeerSyncWithBufferUpdatesTest, ReplaceNodeTest, 
DistributedVersionInfoTest, TestInPlaceUpdatesStandalone, 
HdfsUnloadDistributedZkTest, SolrJmxReporterCloudTest, 
DistribJoinFromCollectionTest, ForceLeaderTest, 
HttpPartitionWithTlogReplicasTest, LegacyCloudClusterPropTest, 
MetricsHistoryIntegrationTest, OverseerTaskQueueTest, RemoteQueryErrorTest, 
SolrXmlInZkTest, SplitShardTest, TestConfigSetsAPI, 
TestSolrCloudWithDelegationTokens, TestSolrCloudWithKerberosAlt, 
TestStressInPlaceUpdates, ZkSolrClientTest, TestCollectionAPI, 
AutoAddReplicasPlanActionTest, IndexSizeTriggerTest, MetricTriggerTest, 
NodeLostTriggerTest, ScheduledMaintenanceTriggerTest, SearchRateTriggerTest, 
SystemLogListenerTest, TestSimComputePlanAction, TestSimDistribStateManager, 
TestSimDistributedQueue, TestSimExtremeIndexing, 
TestSimGenericDistributedQueue, TestSimTriggerIntegration, 
BaseCdcrDistributedZkTest, CdcrBidirectionalTest, CdcrBootstrapTest, 
TestBackupRepositoryFactory, TestConfigOverlay, TestConfigSetProperties, 
TestConfigSets, TestJmxIntegration, TestLazyCores, 
BinaryUpdateRequestHandlerTest, DocumentAnalysisRequestHandlerTest, 
RequestLoggingTest, ResponseBuilderTest, TestConfigReload, 
TestReplicationHandlerBackup, TestSystemCollAutoCreate, CoreAdminOperationTest, 
CoreAdminRequestStatusTest, MBeansHandlerTest, CustomHighlightComponentTest, 
DistributedExpandComponentTest, DistributedMLTComponentTest, 
DistributedQueryElevationComponentTest, ShufflingReplicaListTransformerTest, 
SpellCheckComponentTest, StatsComponentTest, TaggingAttributeTest, 
HighlighterTest, TestLegacyNumericUtils, TestLogWatcher, MetricsConfigTest, 
SolrCoreMetricManagerTest, SolrRrdBackendFactoryTest]
   [junit4] Completed [648/847 (1!)] on J1 in 0.26s, 1 test, 1 failure <<< 
FAILURES!

[...truncated 470 lines...]
   [junit4] Suite: org.apache.solr.security.hadoop.TestDelegationWithHadoopAuth
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.security.hadoop.TestDelegationWithHadoopAuth_EC9EA956AD21863D-001/init-core-data-001
   [junit4]   2> 3769702 INFO  
(SUITE-TestDelegationWithHadoopAuth-seed#[EC9EA956AD21863D]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 3769703 INFO  
(SUITE-TestDelegationWithHadoopAuth-seed#[EC9EA956AD21863D]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 3769703 INFO  
(SUITE-TestDelegationWithHadoopAuth-seed#[EC9EA956AD21863D]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 3769704 INFO  
(SUITE-TestDelegationWithHadoopAuth-seed#[EC9EA956AD21863D]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.security.hadoop.TestDelegationWithHadoopAuth_EC9EA956AD21863D-001/tempDir-001
   [junit4]   2> 3769704 INFO  
(SUITE-TestDelegationWithHadoopAuth-seed#[EC9EA956AD21863D]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 3769705 INFO  (ZkTestServer Run Thread) [    ] 
o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 3769705 INFO  (ZkTestServer Run Thread) [    ] 
o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 3769805 INFO  
(SUITE-TestDelegationWithHadoopAuth-seed#[EC9EA956AD21863D]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:36535
   [junit4]   2> 3769805 INFO  
(SUITE-TestDelegationWithHadoopAuth-seed#[EC9EA956AD21863D]-worker) [    ] 
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:36535
   [junit4]   2> 3769805 INFO  
(SUITE-TestDelegationWithHadoopAuth-seed#[EC9EA956AD21863D]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1 36535
   [junit4]   2> 3769812 INFO  (zkConnectionManagerCallback-12327-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3769826 INFO  (zkConnectionManagerCallback-12329-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3769835 INFO  (zkConnectionManagerCallback-12331-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3769840 WARN  (jetty-launcher-12332-thread-1) [    ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 3769848 WARN  (jetty-launcher-12332-thread-2) [    ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 3769849 INFO  (jetty-launcher-12332-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 3769849 INFO  (jetty-launcher-12332-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 3769849 INFO  (jetty-launcher-12332-thread-2) [    ] 
o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: 
c4550056e785fb5665914545889f21dc136ad9e6; jvm 
12-testing+0-builds.shipilev.net-openjdk-jdk12-b109-20190215-jdk-1229
   [junit4]   2> 3769849 INFO  (jetty-launcher-12332-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 3769849 INFO  (jetty-launcher-12332-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 3769849 INFO  (jetty-launcher-12332-thread-1) [    ] 
o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: 
c4550056e785fb5665914545889f21dc136ad9e6; jvm 
12-testing+0-builds.shipilev.net-openjdk-jdk12-b109-20190215-jdk-1229
   [junit4]   2> 3769867 INFO  (jetty-launcher-12332-thread-2) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 3769867 INFO  (jetty-launcher-12332-thread-2) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 3769867 INFO  (jetty-launcher-12332-thread-2) [    ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 3769869 INFO  (jetty-launcher-12332-thread-1) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 3769869 INFO  (jetty-launcher-12332-thread-1) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 3769869 INFO  (jetty-launcher-12332-thread-1) [    ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 3769872 INFO  (jetty-launcher-12332-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@52946f26{/solr,null,AVAILABLE}
   [junit4]   2> 3769876 INFO  (jetty-launcher-12332-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@67f95914{/solr,null,AVAILABLE}
   [junit4]   2> 3769908 INFO  (jetty-launcher-12332-thread-1) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@5f697850{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:41279}
   [junit4]   2> 3769908 INFO  (jetty-launcher-12332-thread-2) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@3665e9cc{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:37471}
   [junit4]   2> 3769908 INFO  (jetty-launcher-12332-thread-1) [    ] 
o.e.j.s.Server Started @3770012ms
   [junit4]   2> 3769908 INFO  (jetty-launcher-12332-thread-2) [    ] 
o.e.j.s.Server Started @3770013ms
   [junit4]   2> 3769908 INFO  (jetty-launcher-12332-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=41279}
   [junit4]   2> 3769908 INFO  (jetty-launcher-12332-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=37471}
   [junit4]   2> 3769908 ERROR (jetty-launcher-12332-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 3769908 INFO  (jetty-launcher-12332-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 3769908 INFO  (jetty-launcher-12332-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.1.0
   [junit4]   2> 3769908 INFO  (jetty-launcher-12332-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 3769908 INFO  (jetty-launcher-12332-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 3769908 INFO  (jetty-launcher-12332-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-03-14T14:21:56.831815Z
   [junit4]   2> 3769909 ERROR (jetty-launcher-12332-thread-2) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 3769909 INFO  (jetty-launcher-12332-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 3769909 INFO  (jetty-launcher-12332-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.1.0
   [junit4]   2> 3769909 INFO  (jetty-launcher-12332-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 3769909 INFO  (jetty-launcher-12332-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 3769909 INFO  (jetty-launcher-12332-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-03-14T14:21:56.832552Z
   [junit4]   2> 3769918 INFO  (zkConnectionManagerCallback-12334-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3769918 INFO  (zkConnectionManagerCallback-12336-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3769918 INFO  (jetty-launcher-12332-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 3769919 INFO  (jetty-launcher-12332-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 3769926 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 
0x1008006433c0003, likely client has closed socket
   [junit4]   2> 3769926 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 
0x1008006433c0004, likely client has closed socket
   [junit4]   2> 3770047 INFO  (jetty-launcher-12332-thread-1) [    ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 3770049 WARN  (jetty-launcher-12332-thread-1) [    ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
SslContextFactory@5089ffd1[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 3770052 WARN  (jetty-launcher-12332-thread-1) [    ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
SslContextFactory@46f6b68e[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 3770054 INFO  (jetty-launcher-12332-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36535/solr
   [junit4]   2> 3770060 INFO  (zkConnectionManagerCallback-12344-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3770076 INFO  (zkConnectionManagerCallback-12346-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3770147 INFO  (jetty-launcher-12332-thread-1) 
[n:127.0.0.1:41279_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:41279_solr
   [junit4]   2> 3770147 INFO  (jetty-launcher-12332-thread-1) 
[n:127.0.0.1:41279_solr    ] o.a.s.c.Overseer Overseer 
(id=72198358424092678-127.0.0.1:41279_solr-n_0000000000) starting
   [junit4]   2> 3770148 INFO  (jetty-launcher-12332-thread-2) [    ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 3770149 WARN  (jetty-launcher-12332-thread-2) [    ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
SslContextFactory@1e9e8311[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 3770188 WARN  (jetty-launcher-12332-thread-2) [    ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
SslContextFactory@29fedc8c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 3770190 INFO  (jetty-launcher-12332-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36535/solr
   [junit4]   2> 3770212 INFO  (zkConnectionManagerCallback-12355-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3770224 INFO  (jetty-launcher-12332-thread-1) 
[n:127.0.0.1:41279_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:36535/solr ready
   [junit4]   2> 3770235 INFO  
(OverseerStateUpdate-72198358424092678-127.0.0.1:41279_solr-n_0000000000) 
[n:127.0.0.1:41279_solr    ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:41279_solr
   [junit4]   2> 3770243 INFO  (jetty-launcher-12332-thread-1) 
[n:127.0.0.1:41279_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:41279_solr
   [junit4]   2> 3770246 INFO  (jetty-launcher-12332-thread-1) 
[n:127.0.0.1:41279_solr    ] o.a.s.c.CoreContainer Initializing authentication 
plugin: org.apache.solr.security.HadoopAuthPlugin
   [junit4]   2> 3770246 INFO  (jetty-launcher-12332-thread-1) 
[n:127.0.0.1:41279_solr    ] o.a.s.s.HadoopAuthPlugin Params: 
{delegation-token.token-kind=solr-dt, cookie.domain=127.0.0.1, 
zk-dt-secret-manager.znodeWorkingPath=solr/security/zkdtsm, 
signer.secret.provider.zookeeper.path=/token, type=simple, 
zk-dt-secret-manager.enable=true, signer.secret.provider=zookeeper, 
delegation-token.json-mapper.AUTO_CLOSE_TARGET=false}
   [junit4]   2> 3770248 INFO  (zkConnectionManagerCallback-12359-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3770248 INFO  (jetty-launcher-12332-thread-1) 
[n:127.0.0.1:41279_solr    ] o.a.c.f.i.CuratorFrameworkImpl Starting
   [junit4]   2> 3770253 INFO  (zkCallback-12345-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 3770254 DEBUG 
(OverseerAutoScalingTriggerThread-72198358424092678-127.0.0.1:41279_solr-n_0000000000)
 [    ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial 
livenodes: []
   [junit4]   2> 3770266 INFO  (zkCallback-12354-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 3770272 INFO  (jetty-launcher-12332-thread-1-EventThread) [    
] o.a.c.f.s.ConnectionStateManager State change: CONNECTED
   [junit4]   2> 3770287 DEBUG (ScheduledTrigger-11952-thread-1) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 1 and last live nodes: 0
   [junit4]   2> 3770291 INFO  (zkConnectionManagerCallback-12361-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3770300 INFO  (jetty-launcher-12332-thread-2) 
[n:127.0.0.1:37471_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 3770306 INFO  (jetty-launcher-12332-thread-2) 
[n:127.0.0.1:37471_solr    ] o.a.s.c.ZkController Publish 
node=127.0.0.1:37471_solr as DOWN
   [junit4]   2> 3770306 INFO  (jetty-launcher-12332-thread-2) 
[n:127.0.0.1:37471_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 3770306 INFO  (jetty-launcher-12332-thread-2) 
[n:127.0.0.1:37471_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:37471_solr
   [junit4]   2> 3770310 INFO  (zkCallback-12345-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 3770310 INFO  (zkCallback-12354-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 3770312 INFO  (jetty-launcher-12332-thread-2) 
[n:127.0.0.1:37471_solr    ] o.a.s.c.CoreContainer Initializing authentication 
plugin: org.apache.solr.security.HadoopAuthPlugin
   [junit4]   2> 3770312 INFO  (jetty-launcher-12332-thread-2) 
[n:127.0.0.1:37471_solr    ] o.a.s.s.HadoopAuthPlugin Params: 
{delegation-token.token-kind=solr-dt, cookie.domain=127.0.0.1, 
zk-dt-secret-manager.znodeWorkingPath=solr/security/zkdtsm, 
signer.secret.provider.zookeeper.path=/token, type=simple, 
zk-dt-secret-manager.enable=true, signer.secret.provider=zookeeper, 
delegation-token.json-mapper.AUTO_CLOSE_TARGET=false}
   [junit4]   2> 3770315 INFO  (jetty-launcher-12332-thread-2) 
[n:127.0.0.1:37471_solr    ] o.a.c.f.i.CuratorFrameworkImpl Starting
   [junit4]   2> 3770325 INFO  (zkCallback-12360-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 3770326 INFO  (jetty-launcher-12332-thread-2-EventThread) [    
] o.a.c.f.s.ConnectionStateManager State change: CONNECTED
   [junit4]   2> 3770388 INFO  (jetty-launcher-12332-thread-1) 
[n:127.0.0.1:41279_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 3770458 INFO  (jetty-launcher-12332-thread-1) 
[n:127.0.0.1:41279_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_41279.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@43c433b6
   [junit4]   2> 3770472 INFO  (zkConnectionManagerCallback-12369-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3770473 INFO  (jetty-launcher-12332-thread-2) 
[n:127.0.0.1:37471_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 3770474 INFO  (jetty-launcher-12332-thread-2) 
[n:127.0.0.1:37471_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:36535/solr ready
   [junit4]   2> 3770483 INFO  (jetty-launcher-12332-thread-2) 
[n:127.0.0.1:37471_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 3770486 INFO  (jetty-launcher-12332-thread-1) 
[n:127.0.0.1:41279_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_41279.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@43c433b6
   [junit4]   2> 3770486 INFO  (jetty-launcher-12332-thread-1) 
[n:127.0.0.1:41279_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_41279.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@43c433b6
   [junit4]   2> 3770488 INFO  (jetty-launcher-12332-thread-1) 
[n:127.0.0.1:41279_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.security.hadoop.TestDelegationWithHadoopAuth_EC9EA956AD21863D-001/tempDir-001/node1/.
   [junit4]   2> 3770529 INFO  (jetty-launcher-12332-thread-2) 
[n:127.0.0.1:37471_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37471.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@43c433b6
   [junit4]   2> 3770577 INFO  (jetty-launcher-12332-thread-2) 
[n:127.0.0.1:37471_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37471.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@43c433b6
   [junit4]   2> 3770577 INFO  (jetty-launcher-12332-thread-2) 
[n:127.0.0.1:37471_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37471.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@43c433b6
   [junit4]   2> 3770579 INFO  (jetty-launcher-12332-thread-2) 
[n:127.0.0.1:37471_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.security.hadoop.TestDelegationWithHadoopAuth_EC9EA956AD21863D-001/tempDir-001/node2/.
   [junit4]   2> 3770668 INFO  (zkConnectionManagerCallback-12375-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3770670 INFO  
(SUITE-TestDelegationWithHadoopAuth-seed#[EC9EA956AD21863D]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 3770671 INFO  
(SUITE-TestDelegationWithHadoopAuth-seed#[EC9EA956AD21863D]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:36535/solr ready
   [junit4]   2> 3770742 INFO  
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenSolrClient-seed#[EC9EA956AD21863D])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenSolrClient
   [junit4]   2> 3770837 INFO  (qtp174815686-35340) [n:127.0.0.1:41279_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params 
action=LIST&delegation=GgADZm9vA2ZvbwCKAWl8lMJuigFpoKFGbgEDFFO2kQb2UUUNS5EIyaOoPTW089mKB3NvbHItZHQA&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 3770837 INFO  (qtp174815686-35340) [n:127.0.0.1:41279_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=LIST&delegation=GgADZm9vA2ZvbwCKAWl8lMJuigFpoKFGbgEDFFO2kQb2UUUNS5EIyaOoPTW089mKB3NvbHItZHQA&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 3770839 INFO  
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenSolrClient-seed#[EC9EA956AD21863D])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenSolrClient
   [junit4]   2> 3770895 INFO  
(TEST-TestDelegationWithHadoopAuth.testZNodePaths-seed#[EC9EA956AD21863D]) [    
] o.a.s.SolrTestCaseJ4 ###Starting testZNodePaths
   [junit4]   2> 3770932 INFO  (zkConnectionManagerCallback-12377-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3770939 INFO  
(TEST-TestDelegationWithHadoopAuth.testZNodePaths-seed#[EC9EA956AD21863D]) [    
] o.a.s.SolrTestCaseJ4 ###Ending testZNodePaths
   [junit4]   2> 3771027 INFO  
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenCancelFail-seed#[EC9EA956AD21863D])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenCancelFail
   [junit4]   2> 3771056 ERROR (qtp969615163-35341) [    ] 
o.a.h.s.t.d.ZKDelegationTokenSecretManager No node in path 
[/ZKDTSMTokensRoot/DT_3]
   [junit4]   2> 3771057 ERROR (qtp174815686-35338) [    ] 
o.a.h.s.t.d.ZKDelegationTokenSecretManager No node in path 
[/ZKDTSMTokensRoot/DT_3]
   [junit4]   2> 3771071 ERROR (qtp969615163-35339) [    ] 
o.a.h.s.t.d.ZKDelegationTokenSecretManager No node in path 
[/ZKDTSMTokensRoot/DT_4]
   [junit4]   2> 3771073 ERROR (qtp174815686-35340) [n:127.0.0.1:41279_solr    
] o.a.h.s.t.d.ZKDelegationTokenSecretManager No node in path 
[/ZKDTSMTokensRoot/DT_4]
   [junit4]   2> 3771074 INFO  
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenCancelFail-seed#[EC9EA956AD21863D])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenCancelFail
   [junit4]   2> 3771118 INFO  
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenCancel-seed#[EC9EA956AD21863D])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenCancel
   [junit4]   2> 3771129 ERROR (qtp174815686-35338) [    ] 
o.a.h.s.t.d.ZKDelegationTokenSecretManager No node in path 
[/ZKDTSMTokensRoot/DT_5]
   [junit4]   2> 3771159 INFO  (zkConnectionManagerCallback-12382-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3771162 INFO  
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenCancel-seed#[EC9EA956AD21863D])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 3771163 INFO  
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenCancel-seed#[EC9EA956AD21863D])
 [    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 
127.0.0.1:36535/solr ready
   [junit4]   2> 3771184 INFO  (zkConnectionManagerCallback-12387-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3771189 INFO  
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenCancel-seed#[EC9EA956AD21863D])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 3771190 INFO  
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenCancel-seed#[EC9EA956AD21863D])
 [    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 
127.0.0.1:36535/solr ready
   [junit4]   2> 3771216 INFO  (zkConnectionManagerCallback-12392-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3771218 INFO  
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenCancel-seed#[EC9EA956AD21863D])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 3771218 INFO  
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenCancel-seed#[EC9EA956AD21863D])
 [    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 
127.0.0.1:36535/solr ready
   [junit4]   2> 3771220 ERROR (qtp174815686-35342) [    ] 
o.a.h.s.t.d.ZKDelegationTokenSecretManager No node in path 
[/ZKDTSMTokensRoot/DT_6]
   [junit4]   2> 3771243 INFO  (zkConnectionManagerCallback-12397-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3771246 INFO  
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenCancel-seed#[EC9EA956AD21863D])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 3771248 INFO  
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenCancel-seed#[EC9EA956AD21863D])
 [    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 
127.0.0.1:36535/solr ready
   [junit4]   2> 3771252 INFO  
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenCancel-seed#[EC9EA956AD21863D])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenCancel
   [junit4]   2> 3771296 DEBUG (ScheduledTrigger-11952-thread-3) [    ] 
o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with 
currently live nodes: 2 and last live nodes: 1
   [junit4]   2> 3771319 INFO  
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenRenewFail-seed#[EC9EA956AD21863D])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenRenewFail
   [junit4]   2> 3771324 WARN  (qtp174815686-35342) [    ] 
o.a.h.s.a.s.AuthenticationFilter Authentication exception: 
org.apache.hadoop.security.AccessControlException: bar tries to renew a token 
(solr-dt owner=foo, renewer=foo, realUser=, issueDate=1552573318242, 
maxDate=1553178118242, sequenceNumber=7, masterKeyId=3) with non-matching 
renewer foo
   [junit4]   2> 3771324 WARN  (qtp174815686-35342) [    ] 
o.a.s.s.HadoopAuthPlugin Could not find 
org.apache.solr.security.authentication.requestcontinues
   [junit4]   2> 3771332 WARN  (qtp969615163-35343) [    ] 
o.a.h.s.a.s.AuthenticationFilter Authentication exception: 
org.apache.hadoop.security.AccessControlException: bar tries to renew a token 
(solr-dt owner=foo, renewer=foo, realUser=, issueDate=1552573318242, 
maxDate=1553178118242, sequenceNumber=7, masterKeyId=3) with non-matching 
renewer foo
   [junit4]   2> 3771332 WARN  (qtp969615163-35343) [    ] 
o.a.s.s.HadoopAuthPlugin Could not find 
org.apache.solr.security.authentication.requestcontinues
   [junit4]   2> 3771336 WARN  (qtp174815686-35340) [n:127.0.0.1:41279_solr    
] o.a.h.s.a.s.AuthenticationFilter Authentication exception: 
org.apache.hadoop.security.AccessControlException: notRenewUser tries to renew 
a token (solr-dt owner=foo, renewer=renewUser, realUser=, 
issueDate=1552573318256, maxDate=1553178118256, sequenceNumber=8, 
masterKeyId=3) with non-matching renewer renewUser
   [junit4]   2> 3771336 WARN  (qtp174815686-35340) [n:127.0.0.1:41279_solr    
] o.a.s.s.HadoopAuthPlugin Could not find 
org.apache.solr.security.authentication.requestcontinues
   [junit4]   2> 3771337 WARN  (qtp969615163-35339) [    ] 
o.a.h.s.a.s.AuthenticationFilter Authentication exception: 
org.apache.hadoop.security.AccessControlException: notRenewUser tries to renew 
a token (solr-dt owner=foo, renewer=renewUser, realUser=, 
issueDate=1552573318256, maxDate=1553178118256, sequenceNumber=8, 
masterKeyId=3) with non-matching renewer renewUser
   [junit4]   2> 3771337 WARN  (qtp969615163-35339) [    ] 
o.a.s.s.HadoopAuthPlugin Could not find 
org.apache.solr.security.authentication.requestcontinues
   [junit4]   2> 3771338 INFO  
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenRenewFail-seed#[EC9EA956AD21863D])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenRenewFail
   [junit4]   2> 3771415 INFO  
(TEST-TestDelegationWithHadoopAuth.testDelegationOtherOp-seed#[EC9EA956AD21863D])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationOtherOp
   [junit4]   2> 3771465 INFO  (zkConnectionManagerCallback-12402-thread-1) [   
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3771467 INFO  
(TEST-TestDelegationWithHadoopAuth.testDelegationOtherOp-seed#[EC9EA956AD21863D])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 3771467 INFO  
(TEST-TestDelegationWithHadoopAuth.testDelegationOtherOp-seed#[EC9EA956AD21863D])
 [    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 
127.0.0.1:36535/solr ready
   [junit4]   2> 3771469 INFO  (qtp174815686-35338) [n:127.0.0.1:41279_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params 
op=someSolrOperation&action=LIST&user.name=foo&wt=javabin&version=2 and 
sendToOCPQueue=true
   [junit4]   2> 3771469 INFO  (qtp174815686-35338) [n:127.0.0.1:41279_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={op=someSolrOperation&action=LIST&user.name=foo&wt=javabin&version=2} 
status=0 QTime=0
   [junit4]   2> 3771472 INFO  
(TEST-TestDelegationWithHadoopAuth.testDelegationOtherOp-seed#[EC9EA956AD21863D])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationOtherOp
   [junit4]   2> 3771550 INFO  
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenRenew-seed#[EC9EA956AD21863D])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenRenew
   [junit4]   2> 3771556 WARN  (qtp174815686-35342) [    ] 
o.a.h.s.a.s.AuthenticationFilter Authentication exception: 
org.apache.hadoop.security.AccessControlException: foo is trying to renew a 
token (solr-dt owner=foo, renewer=foo, realUser=, issueDate=1552573318474, 
maxDate=1553178118474, sequenceNumber=9, masterKeyId=3) with wrong password
   [junit4]   2> 3771556 WARN  (qtp174815686-35342) [    ] 
o.a.s.s.HadoopAuthPlugin Could not find 
org.apache.solr.security.authentication.requestcontinues
   [junit4]   2> 3771557 INFO  
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenRenew-seed#[EC9EA956AD21863D])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenRenew
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestDelegationWithHadoopAuth -Dtests.method=testDelegationTokenRenew 
-Dtests.seed=EC9EA956AD21863D -Dtests.multiplier=3 -Dtests.slow=true 
-Dtests.locale=en-BZ -Dtests.timezone=Israel -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1
   [junit4] FAILURE 0.09s J1 | 
TestDelegationWithHadoopAuth.testDelegationTokenRenew <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: expected:<200> but 
was:<403>
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([EC9EA956AD21863D:DB055D4895ED5B99]:0)
   [junit4]    >        at 
org.apache.solr.security.hadoop.TestDelegationWithHadoopAuth.renewDelegationToken(TestDelegationWithHadoopAuth.java:120)
   [junit4]    >        at 
org.apache.solr.security.hadoop.TestDelegationWithHadoopAuth.verifyDelegationTokenRenew(TestDelegationWithHadoopAuth.java:303)
   [junit4]    >        at 
org.apache.solr.security.hadoop.TestDelegationWithHadoopAuth.testDelegationTokenRenew(TestDelegationWithHadoopAuth.java:321)
   [junit4]    >        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]    >        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]    >        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]    >        at 
java.base/java.lang.reflect.Method.invoke(Method.java:567)
   [junit4]    >        at java.base/java.lang.Thread.run(Thread.java:835)
   [junit4]   2> 3771621 INFO  
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenVerify-seed#[EC9EA956AD21863D])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenVerify
   [junit4]   2> 3771629 INFO  (qtp174815686-35342) [n:127.0.0.1:41279_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params 
action=LIST&delegation=GgADZm9vA2ZvbwCKAWl8lMWQigFpoKFJkAoDFPvrhMAs94VUj3inQ0alBaCPLGj6B3NvbHItZHQA&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 3771629 INFO  (qtp174815686-35342) [n:127.0.0.1:41279_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=LIST&delegation=GgADZm9vA2ZvbwCKAWl8lMWQigFpoKFJkAoDFPvrhMAs94VUj3inQ0alBaCPLGj6B3NvbHItZHQA&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 3771636 INFO  (qtp969615163-35343) [n:127.0.0.1:37471_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params 
action=LIST&delegation=GgADZm9vA2ZvbwCKAWl8lMWQigFpoKFJkAoDFPvrhMAs94VUj3inQ0alBaCPLGj6B3NvbHItZHQA&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 3771636 INFO  (qtp969615163-35343) [n:127.0.0.1:37471_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=LIST&delegation=GgADZm9vA2ZvbwCKAWl8lMWQigFpoKFJkAoDFPvrhMAs94VUj3inQ0alBaCPLGj6B3NvbHItZHQA&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 3771640 INFO  
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenVerify-seed#[EC9EA956AD21863D])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenVerify
   [junit4]   2> 3771642 INFO  (jetty-closer-12403-thread-1) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=2081207433
   [junit4]   2> 3771642 INFO  (jetty-closer-12403-thread-1) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:41279_solr
   [junit4]   2> 3771643 INFO  (jetty-closer-12403-thread-1) [    ] 
o.a.s.c.CoreContainer Publish this node as DOWN...
   [junit4]   2> 3771643 INFO  (jetty-closer-12403-thread-1) [    ] 
o.a.s.c.ZkController Publish node=127.0.0.1:41279_solr as DOWN
   [junit4]   2> 3771644 INFO  (jetty-closer-12403-thread-2) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=601690364
   [junit4]   2> 3771644 INFO  (jetty-closer-12403-thread-2) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:37471_solr
   [junit4]   2> 3771644 INFO  (jetty-closer-12403-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 3771644 INFO  (jetty-closer-12403-thread-2) [    ] 
o.a.s.c.CoreContainer Publish this node as DOWN...
   [junit4]   2> 3771644 INFO  (jetty-closer-12403-thread-2) [    ] 
o.a.s.c.ZkController Publish node=127.0.0.1:37471_solr as DOWN
   [junit4]   2> 3771645 INFO  (jetty-closer-12403-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 3771645 INFO  (jetty-closer-12403-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@32b4d9df: rootName = 
solr_41279, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@2f8aa31b
   [junit4]   2> 3771647 INFO  (jetty-closer-12403-thread-2) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 3771647 INFO  (jetty-closer-12403-thread-2) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@628743c6: rootName = 
solr_37471, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@16cad3f3
   [junit4]   2> 3771660 INFO  (jetty-closer-12403-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 3771660 INFO  (jetty-closer-12403-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@3f4382f7: rootName = 
solr_41279, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@d34dc21
   [junit4]   2> 3771663 INFO  (jetty-closer-12403-thread-2) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 3771664 INFO  (jetty-closer-12403-thread-2) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@3bf3e4de: rootName = 
solr_37471, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@d34dc21
   [junit4]   2> 3771670 INFO  (jetty-closer-12403-thread-2) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 3771671 INFO  (jetty-closer-12403-thread-2) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@245488f1: rootName = 
solr_37471, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@535b806f
   [junit4]   2> 3771671 INFO  (jetty-closer-12403-thread-2) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 3771672 INFO  (jetty-closer-12403-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 3771672 INFO  (jetty-closer-12403-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@2e4d3d06: rootName = 
solr_41279, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@535b806f
   [junit4]   2> 3771672 INFO  (jetty-closer-12403-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 3771683 INFO  (closeThreadPool-12409-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=72198358424092678-127.0.0.1:41279_solr-n_0000000000) closing
   [junit4]   2> 3771684 INFO  
(OverseerStateUpdate-72198358424092678-127.0.0.1:41279_solr-n_0000000000) 
[n:127.0.0.1:41279_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:41279_solr
   [junit4]   2> 3771685 INFO  
(OverseerAutoScalingTriggerThread-72198358424092678-127.0.0.1:41279_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we 
are closed, exiting.
   [junit4]   2> 3771687 INFO  (zkCallback-12354-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 3771688 INFO  (zkCallback-12345-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 3771691 ERROR 
(Thread[Thread-7581,5,TGRP-TestDelegationWithHadoopAuth]) [    ] 
o.a.h.s.t.d.AbstractDelegationTokenSecretManager ExpiredTokenRemover received 
java.lang.InterruptedException: sleep interrupted
   [junit4]   2> 3771691 INFO  (closeThreadPool-12409-thread-2) [    ] 
o.a.s.c.Overseer Overseer 
(id=72198358424092678-127.0.0.1:41279_solr-n_0000000000) closing
   [junit4]   2> 3771691 INFO  (jetty-closer-12403-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=72198358424092678-127.0.0.1:41279_solr-n_0000000000) closing
   [junit4]   2> 3771693 INFO  (Curator-Framework-0) [    ] 
o.a.c.f.i.CuratorFrameworkImpl backgroundOperationsLoop exiting
   [junit4]   2> 3771712 ERROR 
(Thread[Thread-7579,5,TGRP-TestDelegationWithHadoopAuth]) [    ] 
o.a.h.s.t.d.AbstractDelegationTokenSecretManager ExpiredTokenRemover received 
java.lang.InterruptedException: sleep interrupted
   [junit4]   2> 3771713 INFO  (jetty-closer-12403-thread-2) [    ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@3665e9cc{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:0}
   [junit4]   2> 3771717 INFO  (jetty-closer-12403-thread-2) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@52946f26{/solr,null,UNAVAILABLE}
   [junit4]   2> 3771717 INFO  (jetty-closer-12403-thread-2) [    ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 3771718 INFO  (Curator-Framework-0) [    ] 
o.a.c.f.i.CuratorFrameworkImpl backgroundOperationsLoop exiting
   [junit4]   2> 3771720 INFO  (jetty-closer-12403-thread-1) [    ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@5f697850{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:0}
   [junit4]   2> 3771721 INFO  (jetty-closer-12403-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@67f95914{/solr,null,UNAVAILABLE}
   [junit4]   2> 3771721 INFO  (jetty-closer-12403-thread-1) [    ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 3771722 INFO  
(SUITE-TestDelegationWithHadoopAuth-seed#[EC9EA956AD21863D]-worker) [    ] 
o.a.s.c.ZkTestServer Shutting down ZkTestServer.
   [junit4]   2> 3771723 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>        10      /solr/aliases.json
   [junit4]   2>        10      /solr/clusterprops.json
   [junit4]   2>        2       /solr/security.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        10      /solr/clusterstate.json
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_7
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_6
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_9
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_8
   [junit4]   2>        2       /solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMKeyIdRoot
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot/DK_1
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_1
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot/DK_3
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_3
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_2
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_5
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot/DK_4
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_4
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMSeqNumRoot
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_10
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        10      /solr/live_nodes
   [junit4]   2>        10      /solr/collections
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot
   [junit4]   2> 
   [junit4]   2> 3771725 INFO  
(SUITE-TestDelegationWithHadoopAuth-seed#[EC9EA956AD21863D]-worker) [    ] 
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:36535
   [junit4]   2> 3771725 INFO  
(SUITE-TestDelegationWithHadoopAuth-seed#[EC9EA956AD21863D]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1 36535
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.security.hadoop.TestDelegationWithHadoopAuth_EC9EA956AD21863D-001
   [junit4]   2> Mar 14, 2019 2:21:58 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene80): {}, 
docValues:{}, maxPointsInLeafNode=1212, maxMBSortInHeap=5.981934619654967, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@61173f0a),
 locale=en-BZ, timezone=Israel
   [junit4]   2> NOTE: Linux 4.18.0-15-generic amd64/Aleksey Shipilev 
12-testing (64-bit)/cpus=8,threads=1,free=129830968,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: 
[TestPartialUpdateDeduplication, PropertiesRequestHandlerTest, 
RegexBoostProcessorTest, TriggerSetPropertiesIntegrationTest, 
URLClassifyProcessorTest, TestSafeXMLParsing, 
SignatureUpdateProcessorFactoryTest, TestSQLHandlerNonCloud, 
TriLevelCompositeIdRoutingTest, TestFieldResource, TestRandomFaceting, 
TestCoreDiscovery, HighlighterConfigTest, MultiThreadedOCPTest, 
HdfsSyncSliceTest, TestRandomCollapseQParserPlugin, PeerSyncWithLeaderTest, 
HLLUtilTest, AutoScalingHandlerTest, ScheduledTriggerIntegrationTest, 
TestAuthenticationFramework, TestLFUCache, UninvertDocValuesMergePolicyTest, 
TestBM25SimilarityFactory, TestMaxTokenLenTokenizer, 
QueryElevationComponentTest, OverseerRolesTest, ProtectedTermFilterFactoryTest, 
TestDownShardTolerantSearch, TestRemoteStreaming, TestMultiWordSynonyms, 
CollectionsAPIAsyncDistributedZkTest, TestManagedStopFilterFactory, 
BlockDirectoryTest, AutoscalingHistoryHandlerTest, InfoHandlerTest, 
TestSolrFieldCacheBean, ExternalFileFieldSortTest, UpdateParamsTest, 
TestFieldCache, TestNRTOpen, CloudExitableDirectoryReaderTest, 
SignificantTermsQParserPluginTest, TestSubQueryTransformerDistrib, 
TestAddFieldRealTimeGet, FieldAnalysisRequestHandlerTest, DeleteShardTest, 
TestUpdate, LeaderFailoverAfterPartitionTest, TestSimNodeAddedTrigger, 
TestRealTimeGet, TestCloudSearcherWarming, NodeAddedTriggerTest, 
TestJsonFacets, TestFileDictionaryLookup, TestEmbeddedSolrServerConstructors, 
ShardRoutingCustomTest, TemplateUpdateProcessorTest, 
TestComplexPhraseQParserPlugin, HttpPartitionOnCommitTest, 
SolrCloudReportersTest, TestFacetMethods, SearchHandlerTest, 
SolrRequestParserTest, TestSizeLimitedDistributedMap, BJQParserTest, 
TestQueryTypes, TriggerCooldownIntegrationTest, 
ChaosMonkeySafeLeaderWithPullReplicasTest, TestHighlightDedupGrouping, 
ForceLeaderWithTlogReplicasTest, BasicAuthIntegrationTest, QueryParsingTest, 
TestLeaderElectionWithEmptyReplica, TestNumericRangeQuery32, 
TestCollationField, OverseerTest, TestChildDocTransformerHierarchy, 
TestFieldCacheSortRandom, BlockJoinFacetSimpleTest, 
HdfsChaosMonkeyNothingIsSafeTest, DistributedFacetSimpleRefinementLongTailTest, 
TestHttpShardHandlerFactory, SliceStateTest, CustomCollectionTest, 
TestCloudPseudoReturnFields, TestZkAclsWithHadoopAuth, TestSolrConfigHandler, 
RollingRestartTest, MinimalSchemaTest, TestPullReplica, 
HdfsAutoAddReplicasIntegrationTest, TestDirectoryFactory, 
TestTolerantUpdateProcessorCloud, NumberUtilsTest, 
TestSuggestSpellingConverter, TestStressRecovery, ChangedSchemaMergeTest, 
HttpSolrCallGetCoreTest, DistributedFacetPivotSmallTest, 
HdfsDirectoryFactoryTest, TestFastLRUCache, CollectionPropsTest, 
ByteBuffersDirectoryFactoryTest, SpatialRPTFieldTypeTest, SortByFunctionTest, 
CreateCollectionCleanupTest, TestCloudJSONFacetJoinDomain, 
TestRequestStatusCollectionAPI, FacetPivotSmallTest, 
TestImplicitCoreProperties, SolrIndexSplitterTest, TestSort, SearchHandlerTest, 
TestWithCollection, TestClusterStateMutator, TestDistributedSearch, 
TestCursorMarkWithoutUniqueKey, TestPushWriter, 
TestHighFrequencyDictionaryFactory, MoveReplicaHDFSTest, 
SpellCheckCollatorWithCollapseTest, TestRandomRequestDistribution, 
BasicFunctionalityTest, SOLR749Test, TestPKIAuthenticationPlugin, 
TestSchemaVersionResource, TestReqParamsAPI, CoreSorterTest, 
TestPerFieldSimilarity, HdfsRecoverLeaseTest, TestHdfsCloudBackupRestore, 
TestMiniSolrCloudClusterSSL, PeerSyncWithBufferUpdatesTest, ReplaceNodeTest, 
DistributedVersionInfoTest, TestInPlaceUpdatesStandalone, 
HdfsUnloadDistributedZkTest, SolrJmxReporterCloudTest, 
DistribJoinFromCollectionTest, ForceLeaderTest, 
HttpPartitionWithTlogReplicasTest, LegacyCloudClusterPropTest, 
MetricsHistoryIntegrationTest, OverseerTaskQueueTest, RemoteQueryErrorTest, 
SolrXmlInZkTest, SplitShardTest, TestConfigSetsAPI, 
TestSolrCloudWithDelegationTokens, TestSolrCloudWithKerberosAlt, 
TestStressInPlaceUpdates, ZkSolrClientTest, TestCollectionAPI, 
AutoAddReplicasPlanActionTest, IndexSizeTriggerTest, MetricTriggerTest, 
NodeLostTriggerTest, ScheduledMaintenanceTriggerTest, SearchRateTriggerTest, 
SystemLogListenerTest, TestSimComputePlanAction, TestSimDistribStateManager, 
TestSimDistributedQueue, TestSimExtremeIndexing, 
TestSimGenericDistributedQueue, TestSimTriggerIntegration, 
BaseCdcrDistributedZkTest, CdcrBidirectionalTest, CdcrBootstrapTest, 
TestBackupRepositoryFactory, TestConfigOverlay, TestConfigSetProperties, 
TestConfigSets, TestJmxIntegration, TestLazyCores, 
BinaryUpdateRequestHandlerTest, DocumentAnalysisRequestHandlerTest, 
RequestLoggingTest, ResponseBuilderTest, TestConfigReload, 
TestReplicationHandlerBackup, TestSystemCollAutoCreate, CoreAdminOperationTest, 
CoreAdminRequestStatusTest, MBeansHandlerTest, CustomHighlightComponentTest, 
DistributedExpandComponentTest, DistributedMLTComponentTest, 
DistributedQueryElevationComponentTest, ShufflingReplicaListTransformerTest, 
SpellCheckComponentTest, StatsComponentTest, TaggingAttributeTest, 
HighlighterTest, TestLegacyNumericUtils, TestLogWatcher, MetricsConfigTest, 
SolrCoreMetricManagerTest, SolrRrdBackendFactoryTest, RegexBytesRefFilterTest, 
SimpleFacetsTest, TestMacroExpander, JSONWriterTest, SmileWriterTest, 
TestCustomDocTransformer, TestGraphMLResponseWriter, 
TestRetrieveFieldsOptimizer, TestRestManager, TestBulkSchemaAPI, 
TestManagedSynonymGraphFilterFactory, BooleanFieldTest, CurrencyFieldTypeTest, 
DocValuesMissingTest, EnumFieldTest, IndexSchemaTest, 
ManagedSchemaRoundRobinCloudTest, NotRequiredUniqueKeyTest, 
PreAnalyzedFieldTest, PrimitiveFieldTypeTest, RequiredFieldsTest, 
SchemaVersionSpecificBehaviorTest, TestCloudManagedSchema, 
TestManagedSchemaAPI, TestManagedSchemaThreadSafety, TestOmitPositions, 
TestPointFields, TestPayloadCheckQParserPlugin, TestRTGBase, TestRecoveryHdfs, 
TestDFISimilarityFactory, TestDFRSimilarityFactory, TestIBSimilarityFactory, 
TestLMJelinekMercerSimilarityFactory, TestLegacyBM25SimilarityFactory, 
TestNonDefinedSimilarityFactory, TestDefaultStatsCache, TestExactStatsCache, 
JWTAuthPluginTest, TestDelegationWithHadoopAuth]
   [junit4] Completed [772/847 (2!)] on J1 in 3.01s, 8 tests, 1 failure <<< 
FAILURES!

[...truncated 42778 lines...]
[repro] Jenkins log URL: 
https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Linux/262/consoleText

[repro] Revision: 6571d06c25d7c883162f49f0955f8c0616241c52

[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseG1GC"
[repro] Repro line:  ant test  -Dtestcase=SolrRrdBackendFactoryTest 
-Dtests.method=testBasic -Dtests.seed=EC9EA956AD21863D -Dtests.multiplier=3 
-Dtests.slow=true -Dtests.locale=it-CH -Dtests.timezone=Asia/Seoul 
-Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1

[repro] Repro line:  ant test  -Dtestcase=TestDelegationWithHadoopAuth 
-Dtests.method=testDelegationTokenRenew -Dtests.seed=EC9EA956AD21863D 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=en-BZ 
-Dtests.timezone=Israel -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1

[repro] ant clean

[...truncated 6 lines...]
[repro] Test suites by module:
[repro]    solr/core
[repro]       SolrRrdBackendFactoryTest
[repro]       TestDelegationWithHadoopAuth
[repro] ant compile-test

[...truncated 3580 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=10 
-Dtests.class="*.SolrRrdBackendFactoryTest|*.TestDelegationWithHadoopAuth" 
-Dtests.showOutput=onerror "-Dargs=-XX:-UseCompressedOops -XX:+UseG1GC" 
-Dtests.seed=EC9EA956AD21863D -Dtests.multiplier=3 -Dtests.slow=true 
-Dtests.locale=it-CH -Dtests.timezone=Asia/Seoul -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1

[...truncated 130 lines...]
[repro] Failures:
[repro]   0/5 failed: org.apache.solr.metrics.rrd.SolrRrdBackendFactoryTest
[repro]   0/5 failed: 
org.apache.solr.security.hadoop.TestDelegationWithHadoopAuth
[repro] Exiting with code 0

[...truncated 43 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to