lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Ishan Chattopadhyaya <ichattopadhy...@gmail.com>
Subject Re: [JENKINS] Lucene-Solr-6.x-Linux (32bit/jdk1.8.0_112) - Build # 2681 - Unstable!
Date Tue, 17 Jan 2017 04:13:03 GMT
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 <
jenkins@thetaphi.de> 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: dev-unsubscribe@lucene.apache.org
> For additional commands, e-mail: dev-help@lucene.apache.org
>

Mime
View raw message