Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Solaris/136/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseConcMarkSweepGC
2 tests failed.
FAILED:
junit.framework.TestSuite.org.apache.solr.cloud.TestSolrCloudWithSecureImpersonation
Error Message:
1 thread leaked from SUITE scope at
org.apache.solr.cloud.TestSolrCloudWithSecureImpersonation: 1)
Thread[id=24214, name=jetty-launcher-3682-thread-2-EventThread,
state=TIMED_WAITING, group=TGRP-TestSolrCloudWithSecureImpersonation]
at sun.misc.Unsafe.park(Native Method) at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedNanos(AbstractQueuedSynchronizer.java:1037)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireSharedNanos(AbstractQueuedSynchronizer.java:1328)
at java.util.concurrent.CountDownLatch.await(CountDownLatch.java:277)
at
org.apache.curator.CuratorZookeeperClient.internalBlockUntilConnectedOrTimedOut(CuratorZookeeperClient.java:323)
at org.apache.curator.RetryLoop.callWithRetry(RetryLoop.java:105)
at
org.apache.curator.framework.imps.GetDataBuilderImpl.pathInForeground(GetDataBuilderImpl.java:288)
at
org.apache.curator.framework.imps.GetDataBuilderImpl.forPath(GetDataBuilderImpl.java:279)
at
org.apache.curator.framework.imps.GetDataBuilderImpl.forPath(GetDataBuilderImpl.java:41)
at
org.apache.curator.framework.recipes.shared.SharedValue.readValue(SharedValue.java:244)
at
org.apache.curator.framework.recipes.shared.SharedValue.access$100(SharedValue.java:44)
at
org.apache.curator.framework.recipes.shared.SharedValue$1.process(SharedValue.java:61)
at
org.apache.curator.framework.imps.NamespaceWatcher.process(NamespaceWatcher.java:67)
at
org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:530)
at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:505)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.cloud.TestSolrCloudWithSecureImpersonation:
1) Thread[id=24214, name=jetty-launcher-3682-thread-2-EventThread,
state=TIMED_WAITING, group=TGRP-TestSolrCloudWithSecureImpersonation]
at sun.misc.Unsafe.park(Native Method)
at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedNanos(AbstractQueuedSynchronizer.java:1037)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireSharedNanos(AbstractQueuedSynchronizer.java:1328)
at java.util.concurrent.CountDownLatch.await(CountDownLatch.java:277)
at
org.apache.curator.CuratorZookeeperClient.internalBlockUntilConnectedOrTimedOut(CuratorZookeeperClient.java:323)
at org.apache.curator.RetryLoop.callWithRetry(RetryLoop.java:105)
at
org.apache.curator.framework.imps.GetDataBuilderImpl.pathInForeground(GetDataBuilderImpl.java:288)
at
org.apache.curator.framework.imps.GetDataBuilderImpl.forPath(GetDataBuilderImpl.java:279)
at
org.apache.curator.framework.imps.GetDataBuilderImpl.forPath(GetDataBuilderImpl.java:41)
at
org.apache.curator.framework.recipes.shared.SharedValue.readValue(SharedValue.java:244)
at
org.apache.curator.framework.recipes.shared.SharedValue.access$100(SharedValue.java:44)
at
org.apache.curator.framework.recipes.shared.SharedValue$1.process(SharedValue.java:61)
at
org.apache.curator.framework.imps.NamespaceWatcher.process(NamespaceWatcher.java:67)
at
org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:530)
at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:505)
at __randomizedtesting.SeedInfo.seed([822CD4D4EF4BBA5D]:0)
FAILED:
org.apache.solr.update.processor.UpdateRequestProcessorFactoryTest.testUpdateDistribChainSkipping
Error Message:
Tests must be run with INFO level logging otherwise LogUpdateProcessor isn't
used and can't be tested.
Stack Trace:
java.lang.AssertionError: Tests must be run with INFO level logging otherwise
LogUpdateProcessor isn't used and can't be tested.
at
__randomizedtesting.SeedInfo.seed([822CD4D4EF4BBA5D:F3C82A0299A09D91]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.update.processor.UpdateRequestProcessorFactoryTest.testUpdateDistribChainSkipping(UpdateRequestProcessorFactoryTest.java:101)
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:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
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:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 11780 lines...]
[junit4] Suite:
org.apache.solr.update.processor.UpdateRequestProcessorFactoryTest
[junit4] 2> Creating dataDir:
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.update.processor.UpdateRequestProcessorFactoryTest_822CD4D4EF4BBA5D-001/init-core-data-001
[junit4] 2> 1223155 WARN (coreLoadExecutor-4893-thread-1) [
x:collection1] o.a.s.c.RequestHandlers no default request handler is registered
(either '/select' or 'standard')
[junit4] 2> 1223156 WARN (coreLoadExecutor-4893-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/core/src/test-files/solr/collection1/conf;
switching to use InMemory storage instead.
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=UpdateRequestProcessorFactoryTest
-Dtests.method=testUpdateDistribChainSkipping -Dtests.seed=822CD4D4EF4BBA5D
-Dtests.slow=true -Dtests.locale=it-IT -Dtests.timezone=Europe/Helsinki
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 0.02s J1 |
UpdateRequestProcessorFactoryTest.testUpdateDistribChainSkipping <<<
[junit4] > Throwable #1: java.lang.AssertionError: Tests must be run with
INFO level logging otherwise LogUpdateProcessor isn't used and can't be tested.
[junit4] > at
__randomizedtesting.SeedInfo.seed([822CD4D4EF4BBA5D:F3C82A0299A09D91]:0)
[junit4] > at
org.apache.solr.update.processor.UpdateRequestProcessorFactoryTest.testUpdateDistribChainSkipping(UpdateRequestProcessorFactoryTest.java:101)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> NOTE: leaving temporary files on disk at:
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J1/temp/solr.update.processor.UpdateRequestProcessorFactoryTest_822CD4D4EF4BBA5D-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {},
docValues:{}, maxPointsInLeafNode=678, maxMBSortInHeap=5.608001673009231,
sim=RandomSimilarity(queryNorm=false): {}, locale=it-IT,
timezone=Europe/Helsinki
[junit4] 2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_141
(64-bit)/cpus=3,threads=1,free=123307864,total=308699136
[junit4] 2> NOTE: All tests run in this JVM:
[TestOverriddenPrefixQueryForCustomFieldType, IndexSchemaRuntimeFieldTest,
TestLegacyField, CachingDirectoryFactoryTest, TestOnReconnectListenerSupport,
RequestLoggingTest, TestSchemaResource, LeaderElectionIntegrationTest,
TolerantUpdateProcessorTest, TestSystemIdResolver, ZkFailoverTest,
TestFastLRUCache, TestCopyFieldCollectionResource, TestFastOutputStream,
ConjunctionSolrSpellCheckerTest, TestLRUStatsCache, TestRequestForwarding,
TestJsonRequest, TestDocumentBuilder, SystemInfoHandlerTest,
TestCloudInspectUtil, DistributedMLTComponentTest, TestSolr4Spatial,
DebugComponentTest, TestCollapseQParserPlugin, TestCorePropertiesReload,
TestStressUserVersions, UpdateLogTest, CustomCollectionTest,
BlockDirectoryTest, TestSolrDeletionPolicy1, TestWordDelimiterFilterFactory,
TestDistribDocBasedVersion, TriLevelCompositeIdRoutingTest, HdfsDirectoryTest,
TestCryptoKeys, JSONWriterTest, DistributedFacetPivotLongTailTest,
TestBadConfig, BigEndianAscendingWordDeserializerTest, DOMUtilTest,
TestStressInPlaceUpdates, TestSolr4Spatial2, CdcrReplicationDistributedZkTest,
TestXmlQParser, EnumFieldTest, AliasIntegrationTest, SolrMetricManagerTest,
LukeRequestHandlerTest, DistributedFacetPivotSmallTest,
ExitableDirectoryReaderTest, SpellCheckCollatorTest,
TestLeaderElectionWithEmptyReplica, PluginInfoTest, TestReRankQParserPlugin,
InfoHandlerTest, CoreAdminRequestStatusTest, TestLuceneMatchVersion,
ReplicationFactorTest, TestSolrCloudWithHadoopAuthPlugin,
SpellingQueryConverterTest, TestAnalyzeInfixSuggestions,
TestAuthenticationFramework, TestSolrQueryParser, TestDFISimilarityFactory,
PreAnalyzedUpdateProcessorTest, SolrCoreCheckLockOnStartupTest,
DataDrivenBlockJoinTest, TestRealTimeGet, TestMaxScoreQueryParser,
TestSchemaVersionResource, TestRangeQuery, ConvertedLegacyTest,
TestStressLucene, UtilsToolTest, ConnectionReuseTest, ConnectionManagerTest,
TestDocTermOrds, TestRTGBase, ZkSolrClientTest, ShardRoutingCustomTest,
TestPartialUpdateDeduplication, BasicAuthStandaloneTest,
SuggestComponentContextFilterQueryTest, CloudExitableDirectoryReaderTest,
SpellCheckComponentTest, TestCollationFieldDocValues,
ChaosMonkeyNothingIsSafeWithPullReplicasTest, SolrIndexMetricsTest,
TestFieldCacheReopen, TestIntervalFaceting, AssignTest,
WrapperMergePolicyFactoryTest, DeleteLastCustomShardedReplicaTest,
ClassificationUpdateProcessorIntegrationTest, TestConfigSetProperties,
DistanceUnitsTest, DocumentAnalysisRequestHandlerTest, TestPerFieldSimilarity,
TestTrie, SimpleMLTQParserTest, TestFieldTypeResource,
TestEmbeddedSolrServerAdminHandler, TestFileDictionaryLookup,
TestSchemaManager, TestManagedSchema, CloneFieldUpdateProcessorFactoryTest,
BadCopyFieldTest, TestInitQParser, TestCloudManagedSchema,
MoreLikeThisHandlerTest, TestNumericTerms32, TestDistributedMissingSort,
TestReloadDeadlock, TestCoreDiscovery, TestIndexSearcher, TestDocSet,
TestFieldCacheWithThreads, DistributedQueryElevationComponentTest,
SolrCloudExampleTest, TestSolrJ, TestShortCircuitedRequests, TestApiFramework,
FullSolrCloudDistribCmdsTest, TestChildDocTransformer, TestScoreJoinQPNoScore,
TestSolrIndexConfig, TestEmbeddedSolrServerSchemaAPI,
OverseerModifyCollectionTest, MetricUtilsTest, RollingRestartTest,
TestLRUCache, HdfsBasicDistributedZkTest, NodeMutatorTest,
TestUniqueKeyFieldResource, SegmentsInfoRequestHandlerTest, MoveReplicaTest,
CdcrRequestHandlerTest, TestComponentsName, MoveReplicaHDFSTest,
SolrIndexConfigTest, BasicZkTest, TestSortByMinMaxFunction,
TermVectorComponentTest, DocValuesNotIndexedTest, BlockJoinFacetSimpleTest,
TestManagedSchemaThreadSafety, ShufflingReplicaListTransformerTest,
OpenCloseCoreStressTest, HLLUtilTest, TestAnalyzedSuggestions,
AddSchemaFieldsUpdateProcessorFactoryTest, HttpSolrCallGetCoreTest,
CursorMarkTest, TestExportWriter, BasicFunctionalityTest,
TestSolrCloudSnapshots, TestPushWriter, TestBM25SimilarityFactory,
TestConfigsApi, SolrRequestParserTest, ChangedSchemaMergeTest,
TestMultiWordSynonyms, PeerSyncReplicationTest, TestConfig,
BasicDistributedZk2Test, CollectionStateFormat2Test,
DirectSolrSpellCheckerTest, PreAnalyzedFieldTest, PolyFieldTest,
TestLeaderInitiatedRecoveryThread, SubstringBytesRefFilterTest,
TestSolrCloudWithDelegationTokens, TestRemoteStreaming, ZkStateWriterTest,
UpdateRequestProcessorFactoryTest]
[junit4] Completed [307/731 (1!)] on J1 in 0.42s, 3 tests, 1 failure <<<
FAILURES!
[...truncated 784 lines...]
[junit4] Suite: org.apache.solr.cloud.TestSolrCloudWithSecureImpersonation
[junit4] 2> 2853136 INFO
(SUITE-TestSolrCloudWithSecureImpersonation-seed#[822CD4D4EF4BBA5D]-worker) [
] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir:
/export/home/jenkins/workspace/Lucene-Solr-7.x-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.TestSolrCloudWithSecureImpersonation_822CD4D4EF4BBA5D-001/init-core-data-001
[junit4] 2> 2853137 WARN
(SUITE-TestSolrCloudWithSecureImpersonation-seed#[822CD4D4EF4BBA5D]-worker) [
] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=146 numCloses=146
[junit4] 2> 2853137 INFO
(SUITE-TestSolrCloudWithSecureImpersonation-seed#[822CD4D4EF4BBA5D]-worker) [
] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 2853138 INFO
(SUITE-TestSolrCloudWithSecureImpersonation-seed#[822CD4D4EF4BBA5D]-worker) [
] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 2853174 ERROR (Thread-7329) [ ] o.a.z.s.ZooKeeperServer
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action
on ERROR or SHUTDOWN server state changes
[junit4] 2> 2853282 ERROR (jetty-launcher-3682-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2853283 ERROR (jetty-launcher-3682-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2853482 WARN (jetty-launcher-3682-thread-2)
[n:127.0.0.1:54840_solr ] o.a.s.c.s.i.Krb5HttpClientBuilder
org.apache.solr.client.solrj.impl.Krb5HttpClientBuilder is configured without
specifying system property 'java.security.auth.login.config'
[junit4] 2> 2853543 WARN (jetty-launcher-3682-thread-1)
[n:127.0.0.1:43778_solr ] o.a.s.c.s.i.Krb5HttpClientBuilder
org.apache.solr.client.solrj.impl.Krb5HttpClientBuilder is configured without
specifying system property 'java.security.auth.login.config'
[junit4] 2> 2853564 WARN (jetty-launcher-3682-thread-1)
[n:127.0.0.1:43778_solr ] o.a.s.c.s.i.Krb5HttpClientBuilder
org.apache.solr.client.solrj.impl.Krb5HttpClientBuilder is configured without
specifying system property 'java.security.auth.login.config'
[junit4] 2> 2854513 WARN (jetty-launcher-3682-thread-2)
[n:127.0.0.1:54840_solr ] o.a.s.c.s.i.Krb5HttpClientBuilder
org.apache.solr.client.solrj.impl.Krb5HttpClientBuilder is configured without
specifying system property 'java.security.auth.login.config'
[junit4] 2> 2854593 INFO
(TEST-TestSolrCloudWithSecureImpersonation.testProxyInvalidProxyUser-seed#[822CD4D4EF4BBA5D])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testProxyInvalidProxyUser
[junit4] 2> 2854610 WARN
(TEST-TestSolrCloudWithSecureImpersonation.testProxyInvalidProxyUser-seed#[822CD4D4EF4BBA5D])
[ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth="u=bar&p=bar&t=test&e=1503782337900&s=AwWdJt40KBXybuEwgiNKQmwuZjY=";
Path=/; Domain=127.0.0.1; Expires=sab, 26-ago-2017 21:18:57 GMT; HttpOnly".
Invalid 'expires' attribute: sab, 26-ago-2017 21:18:57 GMT
[junit4] 2> 2854610 INFO
(TEST-TestSolrCloudWithSecureImpersonation.testProxyInvalidProxyUser-seed#[822CD4D4EF4BBA5D])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testProxyInvalidProxyUser
[junit4] 2> 2854628 INFO
(TEST-TestSolrCloudWithSecureImpersonation.testProxyWrongHost-seed#[822CD4D4EF4BBA5D])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testProxyWrongHost
[junit4] 2> 2854666 WARN
(TEST-TestSolrCloudWithSecureImpersonation.testProxyWrongHost-seed#[822CD4D4EF4BBA5D])
[ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth="u=wrongHost&p=wrongHost&t=test&e=1503782337928&s=Rfnd/+VT7tQ1HU2lhAWPc1Y6xMo=";
Path=/; Domain=127.0.0.1; Expires=sab, 26-ago-2017 21:18:57 GMT; HttpOnly".
Invalid 'expires' attribute: sab, 26-ago-2017 21:18:57 GMT
[junit4] 2> 2854666 INFO
(TEST-TestSolrCloudWithSecureImpersonation.testProxyWrongHost-seed#[822CD4D4EF4BBA5D])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testProxyWrongHost
[junit4] 2> 2854685 INFO
(TEST-TestSolrCloudWithSecureImpersonation.testForwarding-seed#[822CD4D4EF4BBA5D])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testForwarding
[junit4] 2> 2856886 WARN
(httpShardExecutor-9038-thread-1-processing-n:127.0.0.1:43778_solr
[http:////127.0.0.1:43778//solr] http:////127.0.0.1:43778//solr)
[n:127.0.0.1:43778_solr ] o.a.h.c.p.ResponseProcessCookies Invalid cookie
header: "Set-Cookie:
hadoop.auth="u=$&p=$&t=test&e=1503782338815&s=algEWZTC2CBJ5kRWCG22f+TDeAM=";
Path=/; Domain=127.0.0.1; Expires=sab, 26-ago-2017 21:18:58 GMT; HttpOnly".
Invalid 'expires' attribute: sab, 26-ago-2017 21:18:58 GMT
[junit4] 2> 2857892 WARN
(TEST-TestSolrCloudWithSecureImpersonation.testForwarding-seed#[822CD4D4EF4BBA5D])
[ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth="u=user&p=user&t=test&e=1503782338491&s=hCBf/qlPaQshVo72f1uEgYSztJY=";
Path=/; Domain=127.0.0.1; Expires=sab, 26-ago-2017 21:18:58 GMT; HttpOnly".
Invalid 'expires' attribute: sab, 26-ago-2017 21:18:58 GMT
[junit4] 2> 2857896 WARN
(TEST-TestSolrCloudWithSecureImpersonation.testForwarding-seed#[822CD4D4EF4BBA5D])
[ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth="u=user&p=user&t=test&e=1503782341195&s=01eLMyCFQT925wQaNMYw8lE2VIM=";
Path=/; Domain=127.0.0.1; Expires=sab, 26-ago-2017 21:19:01 GMT; HttpOnly".
Invalid 'expires' attribute: sab, 26-ago-2017 21:19:01 GMT
[junit4] 2> 2857901 WARN (qtp1336223652-24176) [n:127.0.0.1:54840_solr
] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth="u=$&p=$&t=test&e=1503782341200&s=VPpc2h0sUMS+Sa6xxZUz77vb2VU=";
Path=/; Domain=127.0.0.1; Expires=sab, 26-ago-2017 21:19:01 GMT; HttpOnly".
Invalid 'expires' attribute: sab, 26-ago-2017 21:19:01 GMT
[junit4] 2> 2857901 WARN
(TEST-TestSolrCloudWithSecureImpersonation.testForwarding-seed#[822CD4D4EF4BBA5D])
[ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth="u=user&p=user&t=test&e=1503782341198&s=kClRhF2KxQs8VRpYs5/7DO+Q9Nc=";
Path=/; Domain=127.0.0.1; Expires=sab, 26-ago-2017 21:19:01 GMT; HttpOnly".
Invalid 'expires' attribute: sab, 26-ago-2017 21:19:01 GMT
[junit4] 2> 2857902 WARN
(TEST-TestSolrCloudWithSecureImpersonation.testForwarding-seed#[822CD4D4EF4BBA5D])
[ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth="u=$&p=$&t=test&e=1503782341200&s=VPpc2h0sUMS+Sa6xxZUz77vb2VU=";
Path=/; Domain=127.0.0.1; Expires=sab, 26-ago-2017 21:19:01 GMT; HttpOnly".
Invalid 'expires' attribute: sab, 26-ago-2017 21:19:01 GMT
[junit4] 2> 2857902 INFO
(TEST-TestSolrCloudWithSecureImpersonation.testForwarding-seed#[822CD4D4EF4BBA5D])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testForwarding
[junit4] 2> 2857919 INFO
(TEST-TestSolrCloudWithSecureImpersonation.testProxyNullProxyUser-seed#[822CD4D4EF4BBA5D])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testProxyNullProxyUser
[junit4] 2> 2857924 WARN (qtp1807455815-24172) [ ]
o.e.j.s.ServletHandler /solr/admin/collections
[junit4] 2> org.apache.solr.common.SolrException: Error during request
authentication,
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.authenticateRequest(SolrDispatchFilter.java:457)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:347)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:326)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
[junit4] 2> at
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
[junit4] 2> at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
[junit4] 2> at
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:493)
[junit4] 2> at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
[junit4] 2> at
org.eclipse.jetty.server.Server.handle(Server.java:534)
[junit4] 2> at
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
[junit4] 2> at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
[junit4] 2> at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283)
[junit4] 2> at
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108)
[junit4] 2> at
org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> Caused by: java.lang.IllegalArgumentException: userName is
NULL, empty or contains a '&'
[junit4] 2> at
org.apache.hadoop.security.authentication.util.AuthToken.checkForIllegalArgument(AuthToken.java:87)
[junit4] 2> at
org.apache.hadoop.security.authentication.util.AuthToken.<init>(AuthToken.java:70)
[junit4] 2> at
org.apache.hadoop.security.authentication.server.AuthenticationToken.<init>(AuthenticationToken.java:58)
[junit4] 2> at
org.apache.solr.security.HttpParamDelegationTokenPlugin$HttpParamDelegationTokenAuthenticationHandler$HttpParamAuthenticationHandler.authenticate(HttpParamDelegationTokenPlugin.java:213)
[junit4] 2> at
org.apache.hadoop.security.token.delegation.web.DelegationTokenAuthenticationHandler.authenticate(DelegationTokenAuthenticationHandler.java:348)
[junit4] 2> at
org.apache.solr.security.RequestContinuesRecorderAuthenticationHandler.authenticate(RequestContinuesRecorderAuthenticationHandler.java:69)
[junit4] 2> at
org.apache.hadoop.security.authentication.server.AuthenticationFilter.doFilter(AuthenticationFilter.java:518)
[junit4] 2> at
org.apache.solr.security.DelegationTokenKerberosFilter.doFilter(DelegationTokenKerberosFilter.java:134)
[junit4] 2> at
org.apache.solr.security.HttpParamDelegationTokenPlugin$HttpParamToRequestFilter.doFilter(HttpParamDelegationTokenPlugin.java:245)
[junit4] 2> at
org.apache.solr.security.KerberosPlugin.doAuthenticate(KerberosPlugin.java:243)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.authenticateRequest(SolrDispatchFilter.java:451)
[junit4] 2> ... 26 more
[junit4] 2> 2857925 INFO
(TEST-TestSolrCloudWithSecureImpersonation.testProxyNullProxyUser-seed#[822CD4D4EF4BBA5D])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testProxyNullProxyUser
[junit4] 2> 2857947 INFO
(TEST-TestSolrCloudWithSecureImpersonation.testProxyInvalidGroup-seed#[822CD4D4EF4BBA5D])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testProxyInvalidGroup
[junit4] 2> 2857978 WARN (qtp1807455815-24174) [ ]
o.a.h.s.ShellBasedUnixGroupsMapping got exception trying to get groups for user
bar: id: invalid user name: "bar"
[junit4] 2> id: invalid user name: "bar"
[junit4] 2>
[junit4] 2> 2857979 WARN
(TEST-TestSolrCloudWithSecureImpersonation.testProxyInvalidGroup-seed#[822CD4D4EF4BBA5D])
[ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth="u=bogusGroup&p=bogusGroup&t=test&e=1503782341260&s=097Z5EDDqilxlmz8d5dJUXj4znk=";
Path=/; Domain=127.0.0.1; Expires=sab, 26-ago-2017 21:19:01 GMT; HttpOnly".
Invalid 'expires' attribute: sab, 26-ago-2017 21:19:01 GMT
[junit4] 2> 2857979 INFO
(TEST-TestSolrCloudWithSecureImpersonation.testProxyInvalidGroup-seed#[822CD4D4EF4BBA5D])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testProxyInvalidGroup
[junit4] 2> 2857999 INFO
(TEST-TestSolrCloudWithSecureImpersonation.testProxyInvalidRemote-seed#[822CD4D4EF4BBA5D])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testProxyInvalidRemote
[junit4] 2> 2858028 WARN
(TEST-TestSolrCloudWithSecureImpersonation.testProxyInvalidRemote-seed#[822CD4D4EF4BBA5D])
[ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth="u=localHostAnyGroup&p=localHostAnyGroup&t=test&e=1503782341299&s=HtmOzm3m5jmIDeuGOcUR9r6JQug=";
Path=/; Domain=127.0.0.1; Expires=sab, 26-ago-2017 21:19:01 GMT; HttpOnly".
Invalid 'expires' attribute: sab, 26-ago-2017 21:19:01 GMT
[junit4] 2> 2858028 INFO
(TEST-TestSolrCloudWithSecureImpersonation.testProxyInvalidRemote-seed#[822CD4D4EF4BBA5D])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testProxyInvalidRemote
[junit4] 2> 2858051 INFO
(TEST-TestSolrCloudWithSecureImpersonation.testProxyValidateGroup-seed#[822CD4D4EF4BBA5D])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testProxyValidateGroup
[junit4] 2> 2858068 WARN
(TEST-TestSolrCloudWithSecureImpersonation.testProxyValidateGroup-seed#[822CD4D4EF4BBA5D])
[ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth="u=anyHostUsersGroup&p=anyHostUsersGroup&t=test&e=1503782341352&s=ccJz9TpY9yp8HcnP0zO/ogrgsAw=";
Path=/; Domain=127.0.0.1; Expires=sab, 26-ago-2017 21:19:01 GMT; HttpOnly".
Invalid 'expires' attribute: sab, 26-ago-2017 21:19:01 GMT
[junit4] 2> 2858069 INFO
(TEST-TestSolrCloudWithSecureImpersonation.testProxyValidateGroup-seed#[822CD4D4EF4BBA5D])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testProxyValidateGroup
[junit4] 2> 2858091 INFO
(TEST-TestSolrCloudWithSecureImpersonation.testProxyValidateAnyHostAnyUser-seed#[822CD4D4EF4BBA5D])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testProxyValidateAnyHostAnyUser
[junit4] 2> 2858092 WARN
(TEST-TestSolrCloudWithSecureImpersonation.testProxyValidateAnyHostAnyUser-seed#[822CD4D4EF4BBA5D])
[ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth="u=anyHostAnyUser&p=anyHostAnyUser&t=test&e=1503782341392&s=L0rIvDJSMNxqCf0up4nJ/DAJ2tc=";
Path=/; Domain=127.0.0.1; Expires=sab, 26-ago-2017 21:19:01 GMT; HttpOnly".
Invalid 'expires' attribute: sab, 26-ago-2017 21:19:01 GMT
[junit4] 2> 2858093 INFO
(TEST-TestSolrCloudWithSecureImpersonation.testProxyValidateAnyHostAnyUser-seed#[822CD4D4EF4BBA5D])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testProxyValidateAnyHostAnyUser
[junit4] 2> 2858116 INFO
(TEST-TestSolrCloudWithSecureImpersonation.testProxyNoConfigHosts-seed#[822CD4D4EF4BBA5D])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testProxyNoConfigHosts
[junit4] 2> 2858118 WARN
(TEST-TestSolrCloudWithSecureImpersonation.testProxyNoConfigHosts-seed#[822CD4D4EF4BBA5D])
[ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth="u=noHosts&p=noHosts&t=test&e=1503782341417&s=SnceoBE0PdzEdF711M8ghIRqrMA=";
Path=/; Domain=127.0.0.1; Expires=sab, 26-ago-2017 21:19:01 GMT; HttpOnly".
Invalid 'expires' attribute: sab, 26-ago-2017 21:19:01 GMT
[junit4] 2> 2858118 INFO
(TEST-TestSolrCloudWithSecureImpersonation.testProxyNoConfigHosts-seed#[822CD4D4EF4BBA5D])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testProxyNoConfigHosts
[junit4] 2> 2858139 INFO
(TEST-TestSolrCloudWithSecureImpersonation.testProxyUnknownRemote-seed#[822CD4D4EF4BBA5D])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testProxyUnknownRemote
[junit4] 2> 2868975 WARN
(jetty-launcher-3682-thread-1-SendThread(127.0.0.1:59793))
[n:127.0.0.1:43778_solr ] o.a.z.ClientCnxn Client session timed out, have
not heard from server in 14451ms for sessionid 0x15e1e4426d90008
[junit4] 2> 2868975 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15e1e4426d90008, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 2868975 WARN
(jetty-launcher-3682-thread-2-SendThread(127.0.0.1:59793))
[n:127.0.0.1:54840_solr ] o.a.z.ClientCnxn Client session timed out, have
not heard from server in 14453ms for sessionid 0x15e1e4426d90007
[junit4] 2> 2868975 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15e1e4426d90007, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 2868975 WARN
(TEST-TestSolrCloudWithSecureImpersonation.testProxyUnknownRemote-seed#[822CD4D4EF4BBA5D])
[ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth="u=localHostAnyGroup&p=localHostAnyGroup&t=test&e=1503782341439&s=eDmzffUFbNWXzBcWgAUO137nhe0=";
Path=/; Domain=127.0.0.1; Expires=sab, 26-ago-2017 21:19:01 GMT; HttpOnly".
Invalid 'expires' attribute: sab, 26-ago-2017 21:19:01 GMT
[junit4] 2> 2868976 INFO
(TEST-TestSolrCloudWithSecureImpersonation.testProxyUnknownRemote-seed#[822CD4D4EF4BBA5D])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testProxyUnknownRemote
[junit4] 2> 2868997 INFO
(TEST-TestSolrCloudWithSecureImpersonation.testProxyNoConfigGroups-seed#[822CD4D4EF4BBA5D])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testProxyNoConfigGroups
[junit4] 2> 2868999 WARN
(TEST-TestSolrCloudWithSecureImpersonation.testProxyNoConfigGroups-seed#[822CD4D4EF4BBA5D])
[ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth="u=noGroups&p=noGroups&t=test&e=1503782352298&s=VlU0pQw8wGb75DSW9aebLpWJxfY=";
Path=/; Domain=127.0.0.1; Expires=sab, 26-ago-2017 21:19:12 GMT; HttpOnly".
Invalid 'expires' attribute: sab, 26-ago-2017 21:19:12 GMT
[junit4] 2> 2868999 INFO
(TEST-TestSolrCloudWithSecureImpersonation.testProxyNoConfigGroups-seed#[822CD4D4EF4BBA5D])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testProxyNoConfigGroups
[junit4] 2> 2869024 INFO
(TEST-TestSolrCloudWithSecureImpersonation.testProxyValidateHost-seed#[822CD4D4EF4BBA5D])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testProxyValidateHost
[junit4] 2> 2869025 WARN
(TEST-TestSolrCloudWithSecureImpersonation.testProxyValidateHost-seed#[822CD4D4EF4BBA5D])
[ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth="u=localHostAnyGroup&p=localHostAnyGroup&t=test&e=1503782352325&s=Qt2enn7pczMqLdBU0yAZtwZuurg=";
Path=/; Domain=127.0.0.1; Expires=sab, 26-ago-2017 21:19:12 GMT; HttpOnly".
Invalid 'expires' attribute: sab, 26-ago-2017 21:19:12 GMT
[junit4] 2> 2869026 INFO
(TEST-TestSolrCloudWithSecureImpersonation.testProxyValidateHost-seed#[822CD4D4EF4BBA5D])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testProxyValidateHost
[junit4] 2> 2869095 WARN
(zkCallback-3693-thread-1-processing-n:127.0.0.1:54840_solr)
[n:127.0.0.1:54840_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 2869095 ERROR
(Thread[Thread-7349,5,TGRP-TestSolrCloudWithSecureImpersonation])
[n:127.0.0.1:54840_solr ] o.a.h.s.t.d.AbstractDelegationTokenSecretManager
ExpiredTokenRemover received java.lang.InterruptedException: sleep interrupted
[junit4] 2> 2870613 WARN
(zkCallback-3694-thread-2-processing-n:127.0.0.1:43778_solr)
[n:127.0.0.1:43778_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 2870614 ERROR
(Thread[Thread-7346,5,TGRP-TestSolrCloudWithSecureImpersonation])
[n:127.0.0.1:43778_solr ] o.a.h.s.t.d.AbstractDelegationTokenSecretManager
ExpiredTokenRemover received java.lang.InterruptedException: sleep interrupted
[junit4] 2> 2870618 ERROR
(SUITE-TestSolrCloudWithSecureImpersonation-seed#[822CD4D4EF4BBA5D]-worker) [
] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper
server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 2880680 WARN (Thread-7329) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 3 /solr/aliases.json
[junit4] 2> 3 /solr/clusterprops.json
[junit4] 2> 2 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 6
/solr/collections/forwardingCollection/state.json
[junit4] 2> 3 /solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMKeyIdRoot
[junit4] 2> 3 /solr/clusterstate.json
[junit4] 2> 3
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMSeqNumRoot
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot/DK_1
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot/DK_3
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot/DK_2
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot/DK_4
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 3 /solr/live_nodes
[junit4] 2> 3 /solr/collections
[junit4] 2> 3
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot
[junit4] 2>
[junit4] 2> 2880721 INFO
(SUITE-TestSolrCloudWithSecureImpersonation-seed#[822CD4D4EF4BBA5D]-worker) [
] o.a.s.SolrTestCaseJ4 -------------------------------------------------------
Done waiting for tracked resources to be released
[junit4] 2> Aug 26, 2017 11:19:24 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 2 leaked
thread(s).
[junit4] 2> 2900593 ERROR (jetty-launcher-3682-thread-1-EventThread)
[n:127.0.0.1:43778_solr ] o.a.c.f.i.CuratorFrameworkImpl Watcher exception
[junit4] 2> java.lang.IllegalStateException: Client is not started
[junit4] 2> at
com.google.common.base.Preconditions.checkState(Preconditions.java:149)
[junit4] 2> at
org.apache.curator.CuratorZookeeperClient.getZooKeeper(CuratorZookeeperClient.java:113)
[junit4] 2> at
org.apache.curator.framework.imps.CuratorFrameworkImpl.getZooKeeper(CuratorFrameworkImpl.java:477)
[junit4] 2> at
org.apache.curator.framework.imps.NamespaceFacade.getZooKeeper(NamespaceFacade.java:112)
[junit4] 2> at
org.apache.curator.framework.imps.GetDataBuilderImpl$4.call(GetDataBuilderImpl.java:302)
[junit4] 2> at
org.apache.curator.framework.imps.GetDataBuilderImpl$4.call(GetDataBuilderImpl.java:291)
[junit4] 2> at
org.apache.curator.RetryLoop.callWithRetry(RetryLoop.java:107)
[junit4] 2> at
org.apache.curator.framework.imps.GetDataBuilderImpl.pathInForeground(GetDataBuilderImpl.java:288)
[junit4] 2> at
org.apache.curator.framework.imps.GetDataBuilderImpl.forPath(GetDataBuilderImpl.java:279)
[junit4] 2> at
org.apache.curator.framework.imps.GetDataBuilderImpl.forPath(GetDataBuilderImpl.java:41)
[junit4] 2> at
org.apache.curator.framework.recipes.shared.SharedValue.readValue(SharedValue.java:244)
[junit4] 2> at
org.apache.curator.framework.recipes.shared.SharedValue.access$100(SharedValue.java:44)
[junit4] 2> at
org.apache.curator.framework.recipes.shared.SharedValue$1.process(SharedValue.java:61)
[junit4] 2> at
org.apache.curator.framework.imps.NamespaceWatcher.process(NamespaceWatcher.java:67)
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:530)
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:505)
[junit4] 2> Aug 26, 2017 11:19:44 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> SEVERE: 1 thread leaked from SUITE scope at
org.apache.solr.cloud.TestSolrCloudWithSecureImpersonation:
[junit4] 2> 1) Thread[id=24214,
name=jetty-launcher-3682-thread-2-EventThread, state=TIMED_WAITING,
group=TGRP-TestSolrCloudWithSecureImpersonation]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedNanos(AbstractQueuedSynchronizer.java:1037)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireSharedNanos(AbstractQueuedSynchronizer.java:1328)
[junit4] 2> at
java.util.concurrent.CountDownLatch.await(CountDownLatch.java:277)
[junit4] 2> at
org.apache.curator.CuratorZookeeperClient.internalBlockUntilConnectedOrTimedOut(CuratorZookeeperClient.java:323)
[junit4] 2> at
org.apache.curator.RetryLoop.callWithRetry(RetryLoop.java:105)
[junit4] 2> at
org.apache.curator.framework.imps.GetDataBuilderImpl.pathInForeground(GetDataBuilderImpl.java:288)
[junit4] 2> at
org.apache.curator.framework.imps.GetDataBuilderImpl.forPath(GetDataBuilderImpl.java:279)
[junit4] 2> at
org.apache.curator.framework.imps.GetDataBuilderImpl.forPath(GetDataBuilderImpl.java:41)
[junit4] 2> at
org.apache.curator.framework.recipes.shared.SharedValue.readValue(SharedValue.java:244)
[junit4] 2> at
org.apache.curator.framework.recipes.shared.SharedValue.access$100(SharedValue.java:44)
[junit4] 2> at
org.apache.curator.framework.recipes.shared.SharedValue$1.process(SharedValue.java:61)
[junit4] 2> at
org.apache.curator.framework.imps.NamespaceWatcher.process(NamespaceWatcher.java:67)
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:530)
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:505)
[junit4] 2> Aug 26, 2017 11:19:44 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: Starting to interrupt leaked threads:
[junit4] 2> 1) Thread[id=24214,
name=jetty-launcher-3682-thread-2-EventThread, state=TIMED_WAITING,
group=TGRP-TestSolrCloudWithSecureImpersonation]
[junit4] 2> 2900842 ERROR (jetty-launcher-3682-thread-2-EventThread)
[n:127.0.0.1:54840_solr ] o.a.c.f.i.CuratorFrameworkImpl Watcher exception
[junit4] 2> java.lang.InterruptedException
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedNanos(AbstractQueuedSynchronizer.java:1039)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireSharedNanos(AbstractQueuedSynchronizer.java:1328)
[junit4] 2> at
java.util.concurrent.CountDownLatch.await(CountDownLatch.java:277)
[junit4] 2> at
org.apache.curator.CuratorZookeeperClient.internalBlockUntilConnectedOrTimedOut(CuratorZookeeperClient.java:323)
[junit4] 2> at
org.apache.curator.RetryLoop.callWithRetry(RetryLoop.java:105)
[junit4] 2> at
org.apache.curator.framework.imps.GetDataBuilderImpl.pathInForeground(GetDataBuilderImpl.java:288)
[junit4] 2> at
org.apache.curator.framework.imps.GetDataBuilderImpl.forPath(GetDataBuilderImpl.java:279)
[junit4] 2> at
org.apache.curator.framework.imps.GetDataBuilderImpl.forPath(GetDataBuilderImpl.java:41)
[junit4] 2> at
org.apache.curator.framework.recipes.shared.SharedValue.readValue(SharedValue.java:244)
[junit4] 2> at
org.apache.curator.framework.recipes.shared.SharedValue.access$100(SharedValue.java:44)
[junit4] 2> at
org.apache.curator.framework.recipes.shared.SharedValue$1.process(SharedValue.java:61)
[junit4] 2> at
org.apache.curator.framework.imps.NamespaceWatcher.process(NamespaceWatcher.java:67)
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:530)
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:505)
[junit4] 2> Aug 26, 2017 11:19:44 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: All leaked threads terminated.
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {},
docValues:{}, maxPointsInLeafNode=1436, maxMBSortInHeap=7.24072293814044,
sim=RandomSimilarity(queryNorm=true): {}, locale=it,
timezone=America/St_Barthelemy
[junit4] 2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_141
(64-bit)/cpus=3,threads=1,free=253768072,total=504496128
[junit4] 2> NOTE: All tests run in this JVM:
[OutOfBoxZkACLAndCredentialsProvidersTest, TestPointFields,
SpatialHeatmapFacetsTest, TestDistribIDF, TestPivotHelperCode,
TestAddFieldRealTimeGet, AddBlockUpdateTest, CdcrReplicationHandlerTest,
SolrJmxReporterCloudTest, SortByFunctionTest, XsltUpdateRequestHandlerTest,
TestSizeLimitedDistributedMap, DeleteNodeTest, WordBreakSolrSpellCheckerTest,
ChaosMonkeyNothingIsSafeTest, TestRandomDVFaceting,
TestCloudPseudoReturnFields, ClusterStateTest, ReplaceNodeTest,
HdfsDirectoryFactoryTest, DistributedFacetPivotSmallAdvancedTest,
PrimUtilsTest, TestQuerySenderListener, PrimitiveFieldTypeTest,
TestConfigReload, TestPhraseSuggestions, DistributedExpandComponentTest,
CollectionReloadTest, SpellCheckCollatorWithCollapseTest, HighlighterTest,
OverseerCollectionConfigSetProcessorTest, TestPHPSerializedResponseWriter,
ClassificationUpdateProcessorFactoryTest, SolrSlf4jReporterTest,
SecurityConfHandlerTest, OutputWriterTest, DocValuesMissingTest, RankQueryTest,
ReplicaListTransformerTest, TestCodecSupport, HdfsChaosMonkeyNothingIsSafeTest,
BasicDistributedZkTest, TestHdfsUpdateLog, TestSolrCoreSnapshots,
TestBulkSchemaConcurrent, TestSearcherReuse,
PeerSyncWithIndexFingerprintCachingTest, HdfsRestartWhileUpdatingTest,
ScriptEngineTest, TestConfigSetsAPIZkFailure, TestPullReplicaErrorHandling,
TestSolrConfigHandlerConcurrent, TestIndexingPerformance, TestRTimerTree,
TestUnifiedSolrHighlighter, CurrencyFieldTypeTest,
TestEmbeddedSolrServerConstructors, TestLocalFSCloudBackupRestore,
TestLeaderElectionZkExpiry, SliceStateTest, SparseHLLTest,
TestTolerantUpdateProcessorCloud, DirectSolrConnectionTest, SmileWriterTest,
DistribJoinFromCollectionTest, TestSmileRequest, ConfigureRecoveryStrategyTest,
UUIDFieldTest, SolrGangliaReporterTest, CreateCollectionCleanupTest,
TestExpandComponent, GraphQueryTest, TestLazyCores, DateFieldTest,
QueryParsingTest, OverseerTaskQueueTest, TestPayloadCheckQParserPlugin,
TestConfigSetImmutable, TestImpersonationWithHadoopAuth,
TestInPlaceUpdatesStandalone, UninvertDocValuesMergePolicyTest,
TestRestoreCore, TestSubQueryTransformerDistrib, TestQueryWrapperFilter,
SolrShardReporterTest, CloudMLTQParserTest, UUIDUpdateProcessorFallbackTest,
DistributedFacetPivotWhiteBoxTest, TestNamedUpdateProcessors, JvmMetricsTest,
ZkStateReaderTest, ReturnFieldsTest, AutoScalingHandlerTest,
DisMaxRequestHandlerTest, FacetPivotSmallTest, TestStressVersions,
FieldAnalysisRequestHandlerTest, XmlUpdateRequestHandlerTest,
CoreMergeIndexesAdminHandlerTest, SharedFSAutoReplicaFailoverUtilsTest,
ResponseLogComponentTest, SoftAutoCommitTest, MultiTermTest,
MoveReplicaHDFSUlogDirTest, TestCloudDeleteByQuery, SolrCoreTest,
IndexSchemaTest, TestStressCloudBlindAtomicUpdates,
CollectionTooManyReplicasTest, TestLegacyNumericRangeQueryBuilder,
SolrIndexSplitterTest, TestCustomSort, TestSchemaNameResource,
TestBackupRepositoryFactory, CoreAdminCreateDiscoverTest,
TestJavabinTupleStreamParser, TestDocBasedVersionConstraints,
TestXmlQParserPlugin, PKIAuthenticationIntegrationTest, ForceLeaderTest,
DistributedVersionInfoTest, TestNumericRangeQuery32, RestartWhileUpdatingTest,
TestSurroundQueryParser, TestHdfsCloudBackupRestore, TestSolrDeletionPolicy2,
LeaderElectionTest, RAMDirectoryFactoryTest, TestNonDefinedSimilarityFactory,
TestSerializedLuceneMatchVersion, NotRequiredUniqueKeyTest,
PathHierarchyTokenizerFactoryTest, HdfsLockFactoryTest, TestNumericTerms64,
SuggesterTest, ResourceLoaderTest, SolrCoreMetricManagerTest,
TestHashPartitioner, AsyncCallRequestStatusResponseTest,
TestCloudJSONFacetJoinDomain, CheckHdfsIndexTest,
TestManagedSynonymGraphFilterFactory, TestExtendedDismaxParser,
TestCSVResponseWriter, TestBinaryField, TestSchemaSimilarityResource,
HdfsRecoverLeaseTest, TestLegacyTerms, TestFuzzyAnalyzedSuggestions,
TestInitParams, HighlighterConfigTest, ImplicitSnitchTest, TestJettySolrRunner,
TestLegacyFieldReuse, TestRawResponseWriter, LeaderFailureAfterFreshStartTest,
DeleteShardTest, StatsReloadRaceTest, ManagedSchemaRoundRobinCloudTest,
CleanupOldIndexTest, TestPKIAuthenticationPlugin, TestManagedResourceStorage,
SearchHandlerTest, SSLMigrationTest, HdfsThreadLeakTest,
TestFieldCacheVsDocValues, TestQuerySenderNoQuery, TestNumericTokenStream,
TestSolrXml, TestMacros, TestFaceting, TestTrieFacet, RulesTest,
BigEndianAscendingWordSerializerTest, TestOrdValues, TestSolrCoreProperties,
TestFilteredDocIdSet, TestFieldCacheSort, TestCollectionAPIs,
TestCoreContainer, OverseerTest, RecoveryZkTest, ClusterStateUpdateTest,
TestRandomFaceting, TestZkChroot, ZkCLITest, TestRecovery, ZkControllerTest,
TestReload, DistributedTermsComponentTest, TestGroupingSearch,
SolrCmdDistributorTest, QueryElevationComponentTest, PeerSyncTest,
SuggesterFSTTest, TestFoldingMultitermQuery, DocValuesTest,
DirectUpdateHandlerOptimizeTest, DocValuesMultiTest, DistanceFunctionTest,
SolrInfoBeanTest, IndexBasedSpellCheckerTest, TestWriterPerf, TestQueryTypes,
FileBasedSpellCheckerTest, TermsComponentTest, RequiredFieldsTest,
LoggingHandlerTest, SolrPluginUtilsTest, TestJmxIntegration,
UniqFieldsUpdateProcessorFactoryTest, BinaryUpdateRequestHandlerTest,
PingRequestHandlerTest, TestLFUCache, TestMergePolicyConfig, SampleTest,
TestSearchPerf, NumericFieldsTest, MinimalSchemaTest,
TestElisionMultitermQuery, ExternalFileFieldSortTest,
TestPostingsSolrHighlighter, TestCharFilters, TestXIncludeConfig,
TestSweetSpotSimilarityFactory, TestLMDirichletSimilarityFactory,
TestIBSimilarityFactory, TestFastWriter, OpenExchangeRatesOrgProviderTest,
DateMathParserTest, ZkNodePropsTest, FileUtilsTest, CursorPagingTest,
SolrTestCaseJ4Test, TestCrossCoreJoin, TestCursorMarkWithoutUniqueKey,
TestHighlightDedupGrouping, TestTolerantSearch, ActionThrottleTest,
AssignBackwardCompatibilityTest, ChaosMonkeySafeLeaderWithPullReplicasTest,
CollectionsAPISolrJTest, DeleteStatusTest,
DistribDocExpirationUpdateProcessorTest, LeaderElectionContextKeyTest,
LeaderFailoverAfterPartitionTest, LeaderInitiatedRecoveryOnCommitTest,
MissingSegmentRecoveryTest, OverriddenZkACLAndCredentialsProvidersTest,
OverseerRolesTest, OverseerStatusTest, RecoveryAfterSoftCommitTest,
SaslZkACLProviderTest, SharedFSAutoReplicaFailoverTest,
SimpleCollectionCreateDeleteTest, SolrCLIZkUtilsTest, SolrXmlInZkTest,
TestCloudRecovery, TestCloudSearcherWarming, TestClusterProperties,
TestCollectionAPI, TestConfigSetsAPI, TestPrepRecovery, TestRandomFlRTGCloud,
TestRandomRequestDistribution, TestReplicaProperties, TestSSLRandomization,
TestSegmentSorting, TestSolrCloudWithSecureImpersonation]
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=TestSolrCloudWithSecureImpersonation -Dtests.seed=822CD4D4EF4BBA5D
-Dtests.slow=true -Dtests.locale=it -Dtests.timezone=America/St_Barthelemy
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J0 | TestSolrCloudWithSecureImpersonation (suite) <<<
[junit4] > Throwable #1:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.cloud.TestSolrCloudWithSecureImpersonation:
[junit4] > 1) Thread[id=24214,
name=jetty-launcher-3682-thread-2-EventThread, state=TIMED_WAITING,
group=TGRP-TestSolrCloudWithSecureImpersonation]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] > at
java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedNanos(AbstractQueuedSynchronizer.java:1037)
[junit4] > at
java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireSharedNanos(AbstractQueuedSynchronizer.java:1328)
[junit4] > at
java.util.concurrent.CountDownLatch.await(CountDownLatch.java:277)
[junit4] > at
org.apache.curator.CuratorZookeeperClient.internalBlockUntilConnectedOrTimedOut(CuratorZookeeperClient.java:323)
[junit4] > at
org.apache.curator.RetryLoop.callWithRetry(RetryLoop.java:105)
[junit4] > at
org.apache.curator.framework.imps.GetDataBuilderImpl.pathInForeground(GetDataBuilderImpl.java:288)
[junit4] > at
org.apache.curator.framework.imps.GetDataBuilderImpl.forPath(GetDataBuilderImpl.java:279)
[junit4] > at
org.apache.curator.framework.imps.GetDataBuilderImpl.forPath(GetDataBuilderImpl.java:41)
[junit4] > at
org.apache.curator.framework.recipes.shared.SharedValue.readValue(SharedValue.java:244)
[junit4] > at
org.apache.curator.framework.recipes.shared.SharedValue.access$100(SharedValue.java:44)
[junit4] > at
org.apache.curator.framework.recipes.shared.SharedValue$1.process(SharedValue.java:61)
[junit4] > at
org.apache.curator.framework.imps.NamespaceWatcher.process(NamespaceWatcher.java:67)
[junit4] > at
org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:530)
[junit4] > at
org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:505)
[junit4] > at
__randomizedtesting.SeedInfo.seed([822CD4D4EF4BBA5D]:0)
[junit4] Completed [560/731 (2!)] on J0 in 47.71s, 12 tests, 1 error <<<
FAILURES!
[...truncated 43998 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
