I'll take a look at these failures related to Secure Impersonation and Delegation Tokens tests tomorrow onwards.
On Tue, Jan 17, 2017 at 9:31 AM, Policeman Jenkins Server < [email protected]> wrote: > Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Linux/2681/ > Java: 32bit/jdk1.8.0_112 -server -XX:+UseG1GC > > 1 tests failed. > 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([A46EDC52AFCF9E27: > 93F5284C97034383]:0) > at org.junit.Assert.fail(Assert.java:93) > at org.junit.Assert.failNotEquals(Assert.java:647) > at org.junit.Assert.assertEquals(Assert.java:128) > at org.junit.Assert.assertEquals(Assert.java:472) > at org.junit.Assert.assertEquals(Assert.java:456) > at org.apache.solr.security.hadoop.TestDelegationWithHadoopAuth. > renewDelegationToken(TestDelegationWithHadoopAuth.java:118) > at org.apache.solr.security.hadoop.TestDelegationWithHadoopAuth. > verifyDelegationTokenRenew(TestDelegationWithHadoopAuth.java:301) > at org.apache.solr.security.hadoop.TestDelegationWithHadoopAuth. > testDelegationTokenRenew(TestDelegationWithHadoopAuth.java:318) > 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:367) > at com.carrotsearch.randomizedtesting.ThreadLeakControl. > forkTimeoutingTask(ThreadLeakControl.java:811) > at com.carrotsearch.randomizedtesting. > ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462) > 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:367) > at java.lang.Thread.run(Thread.java:745) > > > > > Build Log: > [...truncated 10879 lines...] > [junit4] Suite: org.apache.solr.security.hadoop. > TestDelegationWithHadoopAuth > [junit4] 2> Creating dataDir: /home/jenkins/workspace/ > Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/ > solr.security.hadoop.TestDelegationWithHadoopAuth_ > A46EDC52AFCF9E27-001/init-core-data-001 > [junit4] 2> 88353 INFO (SUITE-TestDelegationWithHadoopAuth- > seed#[A46EDC52AFCF9E27]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized > ssl (true) and clientAuth (false) via: > @org.apache.solr.util.RandomizeSSL(reason=, > ssl=NaN, value=NaN, clientAuth=NaN) > [junit4] 2> 88354 INFO (SUITE-TestDelegationWithHadoopAuth- > seed#[A46EDC52AFCF9E27]-worker) [ ] o.a.s.c.MiniSolrCloudCluster > Starting cluster of 2 servers in /home/jenkins/workspace/ > Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/ > solr.security.hadoop.TestDelegationWithHadoopAuth_ > A46EDC52AFCF9E27-001/tempDir-001 > [junit4] 2> 88354 INFO (SUITE-TestDelegationWithHadoopAuth- > seed#[A46EDC52AFCF9E27]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK > TEST SERVER > [junit4] 2> 88354 INFO (Thread-221) [ ] o.a.s.c.ZkTestServer > client port:0.0.0.0/0.0.0.0:0 > [junit4] 2> 88355 INFO (Thread-221) [ ] o.a.s.c.ZkTestServer > Starting server > [junit4] 2> 88457 INFO (SUITE-TestDelegationWithHadoopAuth- > seed#[A46EDC52AFCF9E27]-worker) [ ] o.a.s.c.ZkTestServer start zk > server on port:42990 > [junit4] 2> 88480 INFO (jetty-launcher-155-thread-1) [ ] > o.e.j.s.Server jetty-9.3.14.v20161028 > [junit4] 2> 88482 INFO (jetty-launcher-155-thread-1) [ ] > o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@ > e2ffea{/solr,null,AVAILABLE} > [junit4] 2> 88483 INFO (jetty-launcher-155-thread-1) [ ] > o.e.j.s.AbstractConnector Started ServerConnector@6cfda9{SSL,[ssl, > http/1.1]}{127.0.0.1:46858} > [junit4] 2> 88483 INFO (jetty-launcher-155-thread-1) [ ] > o.e.j.s.Server Started @90336ms > [junit4] 2> 88483 INFO (jetty-launcher-155-thread-1) [ ] > o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, > hostPort=46858} > [junit4] 2> 88484 ERROR (jetty-launcher-155-thread-1) [ ] > o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may > be missing or incomplete. > [junit4] 2> 88484 INFO (jetty-launcher-155-thread-1) [ ] > o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ > version 6.5.0 > [junit4] 2> 88485 INFO (jetty-launcher-155-thread-1) [ ] > o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port > null > [junit4] 2> 88485 INFO (jetty-launcher-155-thread-1) [ ] > o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null > [junit4] 2> 88485 INFO (jetty-launcher-155-thread-1) [ ] > o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: > 2017-01-17T03:18:52.436Z > [junit4] 2> 88485 INFO (jetty-launcher-155-thread-2) [ ] > o.e.j.s.Server jetty-9.3.14.v20161028 > [junit4] 2> 88506 INFO (jetty-launcher-155-thread-2) [ ] > o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@ > 66f93b{/solr,null,AVAILABLE} > [junit4] 2> 88506 INFO (jetty-launcher-155-thread-2) [ ] > o.e.j.s.AbstractConnector Started ServerConnector@17a117e{SSL,[ssl, > http/1.1]}{127.0.0.1:39602} > [junit4] 2> 88506 INFO (jetty-launcher-155-thread-2) [ ] > o.e.j.s.Server Started @90358ms > [junit4] 2> 88506 INFO (jetty-launcher-155-thread-2) [ ] > o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, > hostPort=39602} > [junit4] 2> 88506 ERROR (jetty-launcher-155-thread-2) [ ] > o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may > be missing or incomplete. > [junit4] 2> 88507 INFO (jetty-launcher-155-thread-2) [ ] > o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ > version 6.5.0 > [junit4] 2> 88507 INFO (jetty-launcher-155-thread-2) [ ] > o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port > null > [junit4] 2> 88507 INFO (jetty-launcher-155-thread-2) [ ] > o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null > [junit4] 2> 88507 INFO (jetty-launcher-155-thread-2) [ ] > o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: > 2017-01-17T03:18:52.458Z > [junit4] 2> 88509 INFO (jetty-launcher-155-thread-1) [ ] > o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... > [junit4] 2> 88514 INFO (jetty-launcher-155-thread-2) [ ] > o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... > [junit4] 2> 88518 INFO (jetty-launcher-155-thread-1) [ ] > o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with > params: socketTimeout=340000&connTimeout=45000&retry=true > [junit4] 2> 88519 INFO (jetty-launcher-155-thread-1) [ ] > o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42990/solr > [junit4] 2> 88555 INFO (jetty-launcher-155-thread-2) [ ] > o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with > params: socketTimeout=340000&connTimeout=45000&retry=true > [junit4] 2> 88557 INFO (jetty-launcher-155-thread-2) [ ] > o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42990/solr > [junit4] 2> 88573 INFO (jetty-launcher-155-thread-2) > [n:127.0.0.1:39602_solr ] o.a.s.c.OverseerElectionContext I am going > to be the leader 127.0.0.1:39602_solr > [junit4] 2> 88574 INFO (jetty-launcher-155-thread-2) > [n:127.0.0.1:39602_solr ] o.a.s.c.Overseer Overseer > (id=97296261599461382-127.0.0.1:39602_solr-n_0000000000) starting > [junit4] 2> 88589 INFO (jetty-launcher-155-thread-1) > [n:127.0.0.1:46858_solr ] o.a.s.c.ZkController Register node as live > in ZooKeeper:/live_nodes/127.0.0.1:46858_solr > [junit4] 2> 88602 INFO (jetty-launcher-155-thread-2) > [n:127.0.0.1:39602_solr ] o.a.s.c.ZkController Register node as live > in ZooKeeper:/live_nodes/127.0.0.1:39602_solr > [junit4] 2> 88617 INFO (zkCallback-166-thread-2- > processing-n:127.0.0.1:39602_solr) [n:127.0.0.1:39602_solr ] > o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) > [junit4] 2> 88637 INFO (zkCallback-162-thread-1- > processing-n:127.0.0.1:46858_solr) [n:127.0.0.1:46858_solr ] > o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) > [junit4] 2> 88711 INFO (jetty-launcher-155-thread-1) > [n:127.0.0.1:46858_solr ] o.a.s.c.CoreContainer Authentication plugin > class obtained from ZK: org.apache.solr.security.HadoopAuthPlugin > [junit4] 2> 88753 INFO (jetty-launcher-155-thread-1) > [n:127.0.0.1:46858_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} > [junit4] 2> 88758 INFO (jetty-launcher-155-thread-2) > [n:127.0.0.1:39602_solr ] o.a.s.c.CoreContainer Authentication plugin > class obtained from ZK: org.apache.solr.security.HadoopAuthPlugin > [junit4] 2> 88758 INFO (jetty-launcher-155-thread-2) > [n:127.0.0.1:39602_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} > [junit4] 2> 88899 INFO (jetty-launcher-155-thread-1) > [n:127.0.0.1:46858_solr ] o.a.c.f.i.CuratorFrameworkImpl Starting > [junit4] 2> 88899 INFO (jetty-launcher-155-thread-2) > [n:127.0.0.1:39602_solr ] o.a.c.f.i.CuratorFrameworkImpl Starting > [junit4] 2> 88942 INFO (jetty-launcher-155-thread-1-EventThread) > [n:127.0.0.1:46858_solr ] o.a.c.f.s.ConnectionStateManager State > change: CONNECTED > [junit4] 2> 88949 INFO (jetty-launcher-155-thread-2-EventThread) > [n:127.0.0.1:39602_solr ] o.a.c.f.s.ConnectionStateManager State > change: CONNECTED > [junit4] 2> 89226 INFO (jetty-launcher-155-thread-2) > [n:127.0.0.1:39602_solr ] o.a.s.c.CoreContainer > PKIAuthenticationPlugin is managing internode requests > [junit4] 2> 89226 INFO (jetty-launcher-155-thread-1) > [n:127.0.0.1:46858_solr ] o.a.s.c.CoreContainer > PKIAuthenticationPlugin is managing internode requests > [junit4] 2> 89226 INFO (jetty-launcher-155-thread-2) > [n:127.0.0.1:39602_solr ] o.a.s.h.c.HttpShardHandlerFactory > Reconfiguring the default client with: org.apache.solr.security. > PKIAuthenticationPlugin$HttpHeaderClientConfigurer@a30f8d > [junit4] 2> 89226 INFO (jetty-launcher-155-thread-1) > [n:127.0.0.1:46858_solr ] o.a.s.h.c.HttpShardHandlerFactory > Reconfiguring the default client with: org.apache.solr.security. > PKIAuthenticationPlugin$HttpHeaderClientConfigurer@15661fa > [junit4] 2> 89226 INFO (jetty-launcher-155-thread-1) > [n:127.0.0.1:46858_solr ] o.a.s.u.UpdateShardHandler Reconfiguring the > default client with: org.apache.solr.security.PKIAuthenticationPlugin$ > HttpHeaderClientConfigurer@15661fa > [junit4] 2> 89226 INFO (jetty-launcher-155-thread-2) > [n:127.0.0.1:39602_solr ] o.a.s.u.UpdateShardHandler Reconfiguring the > default client with: org.apache.solr.security.PKIAuthenticationPlugin$ > HttpHeaderClientConfigurer@a30f8d > [junit4] 2> 89229 INFO (jetty-launcher-155-thread-1) > [n:127.0.0.1:46858_solr ] o.a.s.c.CorePropertiesLocator Found 0 core > definitions underneath /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/ > build/solr-core/test/J1/temp/solr.security.hadoop. > TestDelegationWithHadoopAuth_A46EDC52AFCF9E27-001/tempDir-001/node1/. > [junit4] 2> 89229 INFO (jetty-launcher-155-thread-2) > [n:127.0.0.1:39602_solr ] o.a.s.c.CorePropertiesLocator Found 0 core > definitions underneath /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/ > build/solr-core/test/J1/temp/solr.security.hadoop. > TestDelegationWithHadoopAuth_A46EDC52AFCF9E27-001/tempDir-001/node2/. > [junit4] 2> 89499 INFO (TEST-TestDelegationWithHadoopAuth. > testDelegationTokenCancelFail-seed#[A46EDC52AFCF9E27]) [ ] > o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenCancelFail > [junit4] 2> 90127 ERROR (qtp16967855-885) [ ] > o.a.h.s.t.d.ZKDelegationTokenSecretManager > No node in path [/ZKDTSMTokensRoot/DT_1] > [junit4] 2> 90130 ERROR (qtp15294662-903) [ ] > o.a.h.s.t.d.ZKDelegationTokenSecretManager > No node in path [/ZKDTSMTokensRoot/DT_1] > [junit4] 2> 90146 ERROR (qtp16967855-891) [ ] > o.a.h.s.t.d.ZKDelegationTokenSecretManager > No node in path [/ZKDTSMTokensRoot/DT_2] > [junit4] 2> 90158 ERROR (qtp15294662-895) [ ] > o.a.h.s.t.d.ZKDelegationTokenSecretManager > No node in path [/ZKDTSMTokensRoot/DT_2] > [junit4] 2> 90163 INFO (TEST-TestDelegationWithHadoopAuth. > testDelegationTokenCancelFail-seed#[A46EDC52AFCF9E27]) [ ] > o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenCancelFail > [junit4] 2> 90188 INFO (TEST-TestDelegationWithHadoopAuth. > testDelegationTokenRenew-seed#[A46EDC52AFCF9E27]) [ ] > o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenRenew > [junit4] 2> 90203 WARN (qtp15294662-903) [ ] > o.a.h.s.a.s.AuthenticationFilter > Authentication exception: org.apache.hadoop.security.AccessControlException: > foo is trying to renew a token with wrong password > [junit4] 2> 90204 WARN (qtp15294662-903) [ ] > o.a.s.s.HadoopAuthPlugin Could not find org.apache.solr.security. > authentication.requestcontinues > [junit4] 2> 90221 INFO (TEST-TestDelegationWithHadoopAuth. > testDelegationTokenRenew-seed#[A46EDC52AFCF9E27]) [ ] > o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenRenew > [junit4] 2> NOTE: reproduce with: ant test > -Dtestcase=TestDelegationWithHadoopAuth > -Dtests.method=testDelegationTokenRenew -Dtests.seed=A46EDC52AFCF9E27 > -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=en-MT > -Dtests.timezone=NET -Dtests.asserts=true -Dtests.file.encoding=UTF-8 > [junit4] FAILURE 0.06s J1 | > TestDelegationWithHadoopAuth.testDelegationTokenRenew > <<< > [junit4] > Throwable #1: java.lang.AssertionError: expected:<200> > but was:<403> > [junit4] > at __randomizedtesting.SeedInfo. > seed([A46EDC52AFCF9E27:93F5284C97034383]:0) > [junit4] > at org.apache.solr.security.hadoop. > TestDelegationWithHadoopAuth.renewDelegationToken( > TestDelegationWithHadoopAuth.java:118) > [junit4] > at org.apache.solr.security.hadoop. > TestDelegationWithHadoopAuth.verifyDelegationTokenRenew( > TestDelegationWithHadoopAuth.java:301) > [junit4] > at org.apache.solr.security.hadoop. > TestDelegationWithHadoopAuth.testDelegationTokenRenew( > TestDelegationWithHadoopAuth.java:318) > [junit4] > at java.lang.Thread.run(Thread.java:745) > [junit4] 2> 90238 INFO (TEST-TestDelegationWithHadoopAuth. > testDelegationTokenCancel-seed#[A46EDC52AFCF9E27]) [ ] > o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenCancel > [junit4] 2> 90284 ERROR (qtp15294662-904) [ ] > o.a.h.s.t.d.ZKDelegationTokenSecretManager > No node in path [/ZKDTSMTokensRoot/DT_4] > [junit4] 2> 90306 INFO (TEST-TestDelegationWithHadoopAuth. > testDelegationTokenCancel-seed#[A46EDC52AFCF9E27]) [ ] > o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) > [junit4] 2> 90307 INFO (TEST-TestDelegationWithHadoopAuth. > testDelegationTokenCancel-seed#[A46EDC52AFCF9E27]) [ ] > o.a.s.c.s.i.ZkClientClusterStateProvider > Cluster at 127.0.0.1:42990/solr ready > [junit4] 2> 90378 INFO (TEST-TestDelegationWithHadoopAuth. > testDelegationTokenCancel-seed#[A46EDC52AFCF9E27]) [ ] > o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) > [junit4] 2> 90379 INFO (TEST-TestDelegationWithHadoopAuth. > testDelegationTokenCancel-seed#[A46EDC52AFCF9E27]) [ ] > o.a.s.c.s.i.ZkClientClusterStateProvider > Cluster at 127.0.0.1:42990/solr ready > [junit4] 2> 90392 ERROR (qtp16967855-888) [ ] > o.a.h.s.t.d.ZKDelegationTokenSecretManager > No node in path [/ZKDTSMTokensRoot/DT_5] > [junit4] 2> 90416 INFO (TEST-TestDelegationWithHadoopAuth. > testDelegationTokenCancel-seed#[A46EDC52AFCF9E27]) [ ] > o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) > [junit4] 2> 90416 INFO (TEST-TestDelegationWithHadoopAuth. > testDelegationTokenCancel-seed#[A46EDC52AFCF9E27]) [ ] > o.a.s.c.s.i.ZkClientClusterStateProvider > Cluster at 127.0.0.1:42990/solr ready > [junit4] 2> 90444 INFO (TEST-TestDelegationWithHadoopAuth. > testDelegationTokenCancel-seed#[A46EDC52AFCF9E27]) [ ] > o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenCancel > [junit4] 2> 90479 INFO (TEST-TestDelegationWithHadoopAuth. > testDelegationOtherOp-seed#[A46EDC52AFCF9E27]) [ ] > o.a.s.SolrTestCaseJ4 ###Starting testDelegationOtherOp > [junit4] 2> 90495 INFO (qtp15294662-904) [n:127.0.0.1:39602_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> 90496 INFO (qtp15294662-904) [n:127.0.0.1:39602_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> 90498 INFO (TEST-TestDelegationWithHadoopAuth. > testDelegationOtherOp-seed#[A46EDC52AFCF9E27]) [ ] > o.a.s.SolrTestCaseJ4 ###Ending testDelegationOtherOp > [junit4] 2> 90530 INFO (TEST-TestDelegationWithHadoopAuth. > testZNodePaths-seed#[A46EDC52AFCF9E27]) [ ] o.a.s.SolrTestCaseJ4 > ###Starting testZNodePaths > [junit4] 2> 90541 INFO (TEST-TestDelegationWithHadoopAuth. > testZNodePaths-seed#[A46EDC52AFCF9E27]) [ ] o.a.s.SolrTestCaseJ4 > ###Ending testZNodePaths > [junit4] 2> 90563 INFO (TEST-TestDelegationWithHadoopAuth. > testDelegationTokenSolrClient-seed#[A46EDC52AFCF9E27]) [ ] > o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenSolrClient > [junit4] 2> 90589 INFO (qtp15294662-896) [n:127.0.0.1:39602_solr > ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params > action=LIST&delegation=GgADZm9vA2ZvbwCKAVmqbz83igFZzn > vDNwcDFIn6hjoafgRnnxmDZfPWGyyJNRxDB3NvbHItZHQA&wt=javabin&version=2 and > sendToOCPQueue=true > [junit4] 2> 90589 INFO (qtp15294662-896) [n:127.0.0.1:39602_solr > ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections > params={action=LIST&delegation=GgADZm9vA2ZvbwCKAVmqbz83igFZzn > vDNwcDFIn6hjoafgRnnxmDZfPWGyyJNRxDB3NvbHItZHQA&wt=javabin&version=2} > status=0 QTime=0 > [junit4] 2> 90589 INFO (TEST-TestDelegationWithHadoopAuth. > testDelegationTokenSolrClient-seed#[A46EDC52AFCF9E27]) [ ] > o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenSolrClient > [junit4] 2> 90610 INFO (TEST-TestDelegationWithHadoopAuth. > testDelegationTokenRenewFail-seed#[A46EDC52AFCF9E27]) [ ] > o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenRenewFail > [junit4] 2> 90620 WARN (qtp15294662-896) [n:127.0.0.1:39602_solr > ] o.a.h.s.a.s.AuthenticationFilter Authentication exception: > org.apache.hadoop.security.AccessControlException: bar tries to renew a > token with renewer foo > [junit4] 2> 90621 WARN (qtp15294662-896) [n:127.0.0.1:39602_solr > ] o.a.s.s.HadoopAuthPlugin Could not find org.apache.solr.security. > authentication.requestcontinues > [junit4] 2> 90624 WARN (qtp16967855-891) [ ] > o.a.h.s.a.s.AuthenticationFilter > Authentication exception: org.apache.hadoop.security.AccessControlException: > bar tries to renew a token with renewer foo > [junit4] 2> 90624 WARN (qtp16967855-891) [ ] > o.a.s.s.HadoopAuthPlugin Could not find org.apache.solr.security. > authentication.requestcontinues > [junit4] 2> 90634 WARN (qtp15294662-895) [ ] > o.a.h.s.a.s.AuthenticationFilter > Authentication exception: org.apache.hadoop.security.AccessControlException: > notRenewUser tries to renew a token with renewer renewUser > [junit4] 2> 90634 WARN (qtp15294662-895) [ ] > o.a.s.s.HadoopAuthPlugin Could not find org.apache.solr.security. > authentication.requestcontinues > [junit4] 2> 90637 WARN (qtp16967855-888) [ ] > o.a.h.s.a.s.AuthenticationFilter > Authentication exception: org.apache.hadoop.security.AccessControlException: > notRenewUser tries to renew a token with renewer renewUser > [junit4] 2> 90638 WARN (qtp16967855-888) [ ] > o.a.s.s.HadoopAuthPlugin Could not find org.apache.solr.security. > authentication.requestcontinues > [junit4] 2> 90639 INFO (TEST-TestDelegationWithHadoopAuth. > testDelegationTokenRenewFail-seed#[A46EDC52AFCF9E27]) [ ] > o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenRenewFail > [junit4] 2> 90656 INFO (TEST-TestDelegationWithHadoopAuth. > testDelegationTokenVerify-seed#[A46EDC52AFCF9E27]) [ ] > o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenVerify > [junit4] 2> 90685 INFO (qtp15294662-903) [n:127.0.0.1:39602_solr > ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params > action=LIST&delegation=GgADZm9vA2ZvbwCKAVmqbz- > gigFZznvDoAoDFNXbr4jy14zNwooEYWtmpErRBZmYB3NvbHItZHQA&wt=javabin&version=2 > and sendToOCPQueue=true > [junit4] 2> 90685 INFO (qtp15294662-903) [n:127.0.0.1:39602_solr > ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections > params={action=LIST&delegation=GgADZm9vA2ZvbwCKAVmqbz- > gigFZznvDoAoDFNXbr4jy14zNwooEYWtmpErRBZmYB3NvbHItZHQA&wt=javabin&version=2} > status=0 QTime=0 > [junit4] 2> 90688 INFO (TEST-TestDelegationWithHadoopAuth. > testDelegationTokenVerify-seed#[A46EDC52AFCF9E27]) [ ] > o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) > [junit4] 2> 90690 INFO (TEST-TestDelegationWithHadoopAuth. > testDelegationTokenVerify-seed#[A46EDC52AFCF9E27]) [ ] > o.a.s.c.s.i.ZkClientClusterStateProvider > Cluster at 127.0.0.1:42990/solr ready > [junit4] 2> 90703 INFO (qtp16967855-891) [n:127.0.0.1:46858_solr > ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params > action=LIST&delegation=GgADZm9vA2ZvbwCKAVmqbz- > gigFZznvDoAoDFNXbr4jy14zNwooEYWtmpErRBZmYB3NvbHItZHQA&wt=javabin&version=2 > and sendToOCPQueue=true > [junit4] 2> 90703 INFO (qtp16967855-891) [n:127.0.0.1:46858_solr > ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections > params={action=LIST&delegation=GgADZm9vA2ZvbwCKAVmqbz- > gigFZznvDoAoDFNXbr4jy14zNwooEYWtmpErRBZmYB3NvbHItZHQA&wt=javabin&version=2} > status=0 QTime=0 > [junit4] 2> 90709 INFO (TEST-TestDelegationWithHadoopAuth. > testDelegationTokenVerify-seed#[A46EDC52AFCF9E27]) [ ] > o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenVerify > [junit4] 2> 90710 INFO (jetty-launcher-155-thread-2) [ ] > o.e.j.s.AbstractConnector Stopped ServerConnector@6cfda9{SSL,[ssl, > http/1.1]}{127.0.0.1:0} > [junit4] 2> 90710 INFO (jetty-launcher-155-thread-1) [ ] > o.e.j.s.AbstractConnector Stopped ServerConnector@17a117e{SSL,[ssl, > http/1.1]}{127.0.0.1:0} > [junit4] 2> 90713 INFO (jetty-launcher-155-thread-2) [ ] > o.a.s.c.CoreContainer Shutting down CoreContainer instance=15930166 > [junit4] 2> 90713 INFO (jetty-launcher-155-thread-1) [ ] > o.a.s.c.CoreContainer Shutting down CoreContainer instance=32340072 > [junit4] 2> 90715 INFO (jetty-launcher-155-thread-1) [ ] > o.a.s.c.Overseer Overseer > (id=97296261599461382-127.0.0.1:39602_solr-n_0000000000) > closing > [junit4] 2> 90716 INFO (OverseerStateUpdate- > 97296261599461382-127.0.0.1:39602_solr-n_0000000000) [n:127.0.0.1:39602_solr > ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:39602_solr > [junit4] 2> 90717 WARN (zkCallback-166-thread-1- > processing-n:127.0.0.1:39602_solr) [n:127.0.0.1:39602_solr ] > o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to > ZK: [KeeperErrorCode = Session expired for /live_nodes] > [junit4] 2> 90717 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 0x159aa6f369c0006, likely client has closed socket > [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO( > NIOServerCnxn.java:228) > [junit4] 2> at org.apache.zookeeper.server. > NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208) > [junit4] 2> at java.lang.Thread.run(Thread.java:745) > [junit4] 2> 90717 INFO (jetty-launcher-155-thread-1) [ ] > o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node > [junit4] 2> 90717 ERROR > (Thread[Thread-239,5,TGRP-TestDelegationWithHadoopAuth]) > [n:127.0.0.1:39602_solr ] o.a.h.s.t.d.AbstractDelegationTokenSecretManager > ExpiredTokenRemover received java.lang.InterruptedException: sleep > interrupted > [junit4] 2> 90738 INFO (jetty-launcher-155-thread-1) [ ] > o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@ > 66f93b{/solr,null,UNAVAILABLE} > [junit4] 2> 92217 WARN (zkCallback-162-thread-2- > processing-n:127.0.0.1:46858_solr) [n:127.0.0.1:46858_solr ] > o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to > ZK: [KeeperErrorCode = Session expired for /live_nodes] > [junit4] 2> 92217 INFO (jetty-launcher-155-thread-2) [ ] > o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node > [junit4] 2> 92217 ERROR > (Thread[Thread-241,5,TGRP-TestDelegationWithHadoopAuth]) > [n:127.0.0.1:46858_solr ] o.a.h.s.t.d.AbstractDelegationTokenSecretManager > ExpiredTokenRemover received java.lang.InterruptedException: sleep > interrupted > [junit4] 2> 92222 INFO (jetty-launcher-155-thread-2) [ ] > o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@ > e2ffea{/solr,null,UNAVAILABLE} > [junit4] 2> 92226 INFO (SUITE-TestDelegationWithHadoopAuth- > seed#[A46EDC52AFCF9E27]-worker) [ ] o.a.s.c.ZkTestServer connecting to > 127.0.0.1:42990 42990 > [junit4] 2> 92251 INFO (Thread-221) [ ] o.a.s.c.ZkTestServer > connecting to 127.0.0.1:42990 42990 > [junit4] 2> 92256 WARN (Thread-221) [ ] o.a.s.c.ZkTestServer > Watch limit violations: > [junit4] 2> Maximum concurrent create/delete watches above limit: > [junit4] 2> > [junit4] 2> 6 /solr/aliases.json > [junit4] 2> 2 /solr/security.json > [junit4] 2> > [junit4] 2> Maximum concurrent data watches above limit: > [junit4] 2> > [junit4] 2> 6 /solr/clusterprops.json > [junit4] 2> 6 /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> 6 /solr/live_nodes > [junit4] 2> 6 /solr/collections > [junit4] 2> 3 /solr/overseer/collection-queue-work > [junit4] 2> 2 /solr/security/zkdtsm/ > ZKDTSMRoot/ZKDTSMMasterKeyRoot > [junit4] 2> 2 /solr/security/zkdtsm/ > ZKDTSMRoot/ZKDTSMTokensRoot > [junit4] 2> > [junit4] 2> 92258 INFO (SUITE-TestDelegationWithHadoopAuth- > seed#[A46EDC52AFCF9E27]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore > [junit4] 2> NOTE: leaving temporary files on disk at: > /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/ > build/solr-core/test/J1/temp/solr.security.hadoop. > TestDelegationWithHadoopAuth_A46EDC52AFCF9E27-001 > [junit4] 2> Jan 17, 2017 3:18:56 AM com.carrotsearch. > randomizedtesting.ThreadLeakControl checkThreadLeaks > [junit4] 2> WARNING: Will linger awaiting termination of 2 leaked > thread(s). > [junit4] 2> NOTE: test params are: codec=Asserting(Lucene62): {}, > docValues:{}, maxPointsInLeafNode=1876, maxMBSortInHeap=5.807162234361133, > sim=RandomSimilarity(queryNorm=true,coord=yes): {}, locale=en-MT, > timezone=NET > [junit4] 2> NOTE: Linux 4.4.0-53-generic i386/Oracle Corporation > 1.8.0_112 (32-bit)/cpus=12,threads=1,free=45282128,total=235929600 > [junit4] 2> NOTE: All tests run in this JVM: [SimpleMLTQParserTest, > DocValuesNotIndexedTest, TestMacroExpander, > HdfsTlogReplayBufferedWhileIndexingTest, > IgnoreCommitOptimizeUpdateProcessorFactoryTest, HighlighterTest, > ShardRoutingCustomTest, TestLRUCache, SolrInfoMBeanTest, > BigEndianAscendingWordSerializerTest, TestAnalyzeInfixSuggestions, > RulesTest, MoreLikeThisHandlerTest, SpellCheckCollatorTest, SampleTest, > SolrIndexMetricsTest, EchoParamsTest, BaseCdcrDistributedZkTest, > TermsComponentTest, HdfsRestartWhileUpdatingTest, TestFieldCacheReopen, > BooleanFieldTest, DeleteNodeTest, TestSchemaSimilarityResource, > SimplePostToolTest, CachingDirectoryFactoryTest, > TestDelegationWithHadoopAuth] > [junit4] Completed [36/680 (1!)] on J1 in 4.95s, 8 tests, 1 failure <<< > FAILURES! > > [...truncated 56774 lines...] > > > > --------------------------------------------------------------------- > To unsubscribe, e-mail: [email protected] > For additional commands, e-mail: [email protected] >
