lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@thetaphi.de>
Subject [JENKINS] Lucene-Solr-master-Windows (64bit/jdk1.8.0_102) - Build # 6148 - Unstable!
Date Fri, 30 Sep 2016 09:53:44 GMT
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/6148/
Java: 64bit/jdk1.8.0_102 -XX:+UseCompressedOops -XX:+UseParallelGC

1 tests failed.
FAILED:  org.apache.solr.cloud.TestSolrCloudWithDelegationTokens.testDelegationTokenCancelFail

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

Stack Trace:
java.lang.AssertionError: expected:<200> but was:<404>
	at __randomizedtesting.SeedInfo.seed([8954809E5D3BC698:E1EBB5B48DA1D474]: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.cloud.TestSolrCloudWithDelegationTokens.cancelDelegationToken(TestSolrCloudWithDelegationTokens.java:137)
	at org.apache.solr.cloud.TestSolrCloudWithDelegationTokens.testDelegationTokenCancelFail(TestSolrCloudWithDelegationTokens.java:282)
	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:1764)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
	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:809)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
	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 12164 lines...]
   [junit4] Suite: org.apache.solr.cloud.TestSolrCloudWithDelegationTokens
   [junit4]   2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestSolrCloudWithDelegationTokens_8954809E5D3BC698-001\init-core-data-001
   [junit4]   2> 3248931 INFO  (SUITE-TestSolrCloudWithDelegationTokens-seed#[8954809E5D3BC698]-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> 3248938 INFO  (SUITE-TestSolrCloudWithDelegationTokens-seed#[8954809E5D3BC698]-worker) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 3248939 INFO  (Thread-4357) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 3248939 INFO  (Thread-4357) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 3249040 INFO  (SUITE-TestSolrCloudWithDelegationTokens-seed#[8954809E5D3BC698]-worker) [    ] o.a.s.c.ZkTestServer start zk server on port:56189
   [junit4]   2> 3249053 INFO  (jetty-launcher-3486-thread-1) [    ] o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 3249054 INFO  (jetty-launcher-3486-thread-1) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4ea5bede{/solr,null,AVAILABLE}
   [junit4]   2> 3249054 INFO  (jetty-launcher-3486-thread-2) [    ] o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 3249056 INFO  (jetty-launcher-3486-thread-1) [    ] o.e.j.s.ServerConnector Started ServerConnector@2e14a9e7{HTTP/1.1,[http/1.1]}{127.0.0.1:56193}
   [junit4]   2> 3249056 INFO  (jetty-launcher-3486-thread-1) [    ] o.e.j.s.Server Started @3255178ms
   [junit4]   2> 3249056 INFO  (jetty-launcher-3486-thread-1) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=56193}
   [junit4]   2> 3249057 INFO  (jetty-launcher-3486-thread-1) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 7.0.0
   [junit4]   2> 3249057 INFO  (jetty-launcher-3486-thread-1) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 3249057 INFO  (jetty-launcher-3486-thread-1) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 3249057 INFO  (jetty-launcher-3486-thread-1) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2016-09-30T09:24:30.485Z
   [junit4]   2> 3249061 INFO  (jetty-launcher-3486-thread-2) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6fbd0df1{/solr,null,AVAILABLE}
   [junit4]   2> 3249067 INFO  (jetty-launcher-3486-thread-2) [    ] o.e.j.s.ServerConnector Started ServerConnector@22522d8d{HTTP/1.1,[http/1.1]}{127.0.0.1:56198}
   [junit4]   2> 3249068 INFO  (jetty-launcher-3486-thread-2) [    ] o.e.j.s.Server Started @3255190ms
   [junit4]   2> 3249068 INFO  (jetty-launcher-3486-thread-2) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=56198}
   [junit4]   2> 3249069 INFO  (jetty-launcher-3486-thread-2) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 7.0.0
   [junit4]   2> 3249069 INFO  (jetty-launcher-3486-thread-2) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 3249069 INFO  (jetty-launcher-3486-thread-2) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 3249069 INFO  (jetty-launcher-3486-thread-1) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 3249069 INFO  (jetty-launcher-3486-thread-2) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2016-09-30T09:24:30.497Z
   [junit4]   2> 3249077 INFO  (jetty-launcher-3486-thread-2) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 3249102 INFO  (jetty-launcher-3486-thread-2) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56189/solr
   [junit4]   2> 3249102 INFO  (jetty-launcher-3486-thread-1) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56189/solr
   [junit4]   2> 3249108 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 0x1577a68ca250003, 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> 3249151 INFO  (jetty-launcher-3486-thread-1) [n:127.0.0.1:56193_solr    ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:56193_solr
   [junit4]   2> 3249152 INFO  (jetty-launcher-3486-thread-2) [n:127.0.0.1:56198_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:56198_solr
   [junit4]   2> 3249153 INFO  (jetty-launcher-3486-thread-1) [n:127.0.0.1:56193_solr    ] o.a.s.c.Overseer Overseer (id=96680507498364933-127.0.0.1:56193_solr-n_0000000000) starting
   [junit4]   2> 3249156 INFO  (zkCallback-3497-thread-1-processing-n:127.0.0.1:56193_solr) [n:127.0.0.1:56193_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 3249157 INFO  (zkCallback-3496-thread-1-processing-n:127.0.0.1:56198_solr) [n:127.0.0.1:56198_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 3249167 INFO  (jetty-launcher-3486-thread-1) [n:127.0.0.1:56193_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:56193_solr
   [junit4]   2> 3249170 INFO  (zkCallback-3497-thread-1-processing-n:127.0.0.1:56193_solr) [n:127.0.0.1:56193_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 3249170 INFO  (zkCallback-3496-thread-1-processing-n:127.0.0.1:56198_solr) [n:127.0.0.1:56198_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 3249171 INFO  (jetty-launcher-3486-thread-2) [n:127.0.0.1:56198_solr    ] o.a.s.c.CoreContainer Authentication plugin class obtained from system property 'authenticationPlugin': org.apache.solr.security.HttpParamDelegationTokenPlugin
   [junit4]   2> 3249176 INFO  (jetty-launcher-3486-thread-1) [n:127.0.0.1:56193_solr    ] o.a.s.c.CoreContainer Authentication plugin class obtained from system property 'authenticationPlugin': org.apache.solr.security.HttpParamDelegationTokenPlugin
   [junit4]   2> 3249279 INFO  (jetty-launcher-3486-thread-2) [n:127.0.0.1:56198_solr    ] o.a.s.s.KerberosPlugin Params: {token.valid=30, delegation-token.token-kind=solr-dt, cookie.domain=127.0.0.1, cookie.path=/, zk-dt-secret-manager.znodeWorkingPath=solr/security/zkdtsm, token.validity=36000, signer.secret.provider.zookeeper.path=/token, type=kerberos, zk-dt-secret-manager.enable=true, kerberos.name.rules=DEFAULT, signer.secret.provider=zookeeper}
   [junit4]   2> 3249279 INFO  (jetty-launcher-3486-thread-1) [n:127.0.0.1:56193_solr    ] o.a.s.s.KerberosPlugin Params: {token.valid=30, delegation-token.token-kind=solr-dt, cookie.domain=127.0.0.1, cookie.path=/, zk-dt-secret-manager.znodeWorkingPath=solr/security/zkdtsm, token.validity=36000, signer.secret.provider.zookeeper.path=/token, type=kerberos, zk-dt-secret-manager.enable=true, kerberos.name.rules=DEFAULT, signer.secret.provider=zookeeper}
   [junit4]   2> 3249698 INFO  (jetty-launcher-3486-thread-2) [n:127.0.0.1:56198_solr    ] o.a.c.f.i.CuratorFrameworkImpl Starting
   [junit4]   2> 3249698 INFO  (jetty-launcher-3486-thread-1) [n:127.0.0.1:56193_solr    ] o.a.c.f.i.CuratorFrameworkImpl Starting
   [junit4]   2> 3249802 INFO  (jetty-launcher-3486-thread-1-EventThread) [n:127.0.0.1:56193_solr    ] o.a.c.f.s.ConnectionStateManager State change: CONNECTED
   [junit4]   2> 3249802 INFO  (jetty-launcher-3486-thread-2-EventThread) [n:127.0.0.1:56198_solr    ] o.a.c.f.s.ConnectionStateManager State change: CONNECTED
   [junit4]   2> 3250135 ERROR (jetty-launcher-3486-thread-2) [n:127.0.0.1:56198_solr    ] o.a.h.u.Shell Failed to locate the winutils binary in the hadoop binary path
   [junit4]   2> java.io.IOException: Could not locate executable null\bin\winutils.exe in the Hadoop binaries.
   [junit4]   2> 	at org.apache.hadoop.util.Shell.getQualifiedBinPath(Shell.java:356)
   [junit4]   2> 	at org.apache.hadoop.util.Shell.getWinUtilsPath(Shell.java:371)
   [junit4]   2> 	at org.apache.hadoop.util.Shell.<clinit>(Shell.java:364)
   [junit4]   2> 	at org.apache.hadoop.util.StringUtils.<clinit>(StringUtils.java:80)
   [junit4]   2> 	at org.apache.hadoop.conf.Configuration.getBoolean(Configuration.java:1437)
   [junit4]   2> 	at org.apache.hadoop.security.token.delegation.web.DelegationTokenManager.<init>(DelegationTokenManager.java:115)
   [junit4]   2> 	at org.apache.hadoop.security.token.delegation.web.DelegationTokenAuthenticationHandler.initTokenManager(DelegationTokenAuthenticationHandler.java:148)
   [junit4]   2> 	at org.apache.hadoop.security.token.delegation.web.DelegationTokenAuthenticationHandler.init(DelegationTokenAuthenticationHandler.java:118)
   [junit4]   2> 	at org.apache.solr.security.HttpParamDelegationTokenPlugin$HttpParamDelegationTokenAuthenticationHandler.init(HttpParamDelegationTokenPlugin.java:178)
   [junit4]   2> 	at org.apache.hadoop.security.authentication.server.AuthenticationFilter.initializeAuthHandler(AuthenticationFilter.java:238)
   [junit4]   2> 	at org.apache.hadoop.security.token.delegation.web.DelegationTokenAuthenticationFilter.initializeAuthHandler(DelegationTokenAuthenticationFilter.java:209)
   [junit4]   2> 	at org.apache.solr.security.DelegationTokenKerberosFilter.initializeAuthHandler(DelegationTokenKerberosFilter.java:137)
   [junit4]   2> 	at org.apache.hadoop.security.authentication.server.AuthenticationFilter.init(AuthenticationFilter.java:227)
   [junit4]   2> 	at org.apache.hadoop.security.token.delegation.web.DelegationTokenAuthenticationFilter.init(DelegationTokenAuthenticationFilter.java:175)
   [junit4]   2> 	at org.apache.solr.security.DelegationTokenKerberosFilter.init(DelegationTokenKerberosFilter.java:66)
   [junit4]   2> 	at org.apache.solr.security.HttpParamDelegationTokenPlugin.init(HttpParamDelegationTokenPlugin.java:134)
   [junit4]   2> 	at org.apache.solr.core.CoreContainer.initializeAuthenticationPlugin(CoreContainer.java:320)
   [junit4]   2> 	at org.apache.solr.core.CoreContainer.load(CoreContainer.java:468)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.createCoreContainer(SolrDispatchFilter.java:203)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.init(SolrDispatchFilter.java:152)
   [junit4]   2> 	at org.eclipse.jetty.servlet.FilterHolder.initialize(FilterHolder.java:137)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.initialize(ServletHandler.java:856)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.updateMappings(ServletHandler.java:1542)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.setFilterMappings(ServletHandler.java:1576)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.addFilterMapping(ServletHandler.java:1268)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.addFilterWithMapping(ServletHandler.java:1113)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletContextHandler.addFilter(ServletContextHandler.java:447)
   [junit4]   2> 	at org.apache.solr.client.solrj.embedded.JettySolrRunner$1.lifeCycleStarted(JettySolrRunner.java:258)
   [junit4]   2> 	at org.eclipse.jetty.util.component.AbstractLifeCycle.setStarted(AbstractLifeCycle.java:179)
   [junit4]   2> 	at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:69)
   [junit4]   2> 	at org.apache.solr.client.solrj.embedded.JettySolrRunner.start(JettySolrRunner.java:342)
   [junit4]   2> 	at org.apache.solr.client.solrj.embedded.JettySolrRunner.start(JettySolrRunner.java:315)
   [junit4]   2> 	at org.apache.solr.cloud.MiniSolrCloudCluster.startJettySolrRunner(MiniSolrCloudCluster.java:345)
   [junit4]   2> 	at org.apache.solr.cloud.MiniSolrCloudCluster.lambda$new$0(MiniSolrCloudCluster.java:212)
   [junit4]   2> 	at java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]   2> 	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 3250512 INFO  (jetty-launcher-3486-thread-2) [n:127.0.0.1:56198_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestSolrCloudWithDelegationTokens_8954809E5D3BC698-001\tempDir-001\node2\.
   [junit4]   2> 3250513 INFO  (jetty-launcher-3486-thread-1) [n:127.0.0.1:56193_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestSolrCloudWithDelegationTokens_8954809E5D3BC698-001\tempDir-001\node1\.
   [junit4]   2> 3250518 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 0x1577a68ca250009, 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> 3250552 INFO  (TEST-TestSolrCloudWithDelegationTokens.testZNodePaths-seed#[8954809E5D3BC698]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testZNodePaths
   [junit4]   2> 3252373 INFO  (TEST-TestSolrCloudWithDelegationTokens.testZNodePaths-seed#[8954809E5D3BC698]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testZNodePaths
   [junit4]   2> 3252396 INFO  (TEST-TestSolrCloudWithDelegationTokens.testDelegationOtherOp-seed#[8954809E5D3BC698]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationOtherOp
   [junit4]   2> 3252438 INFO  (qtp101561700-18586) [n:127.0.0.1:56198_solr    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params op=someSolrOperation&action=LIST&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 3252438 INFO  (qtp101561700-18586) [n:127.0.0.1:56198_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={op=someSolrOperation&action=LIST&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 3252453 WARN  (TEST-TestSolrCloudWithDelegationTokens.testDelegationOtherOp-seed#[8954809E5D3BC698]) [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth="u=bar&p=bar&t=test&e=1475263473845&s=Ic+BLckcAgnbKhTCKjW5k5V73hc="; Path=/; Domain=127.0.0.1; Expires=vie, 30-sep-2016 19:24:33 GMT; HttpOnly". Invalid 'expires' attribute: vie, 30-sep-2016 19:24:33 GMT
   [junit4]   2> 3252454 INFO  (TEST-TestSolrCloudWithDelegationTokens.testDelegationOtherOp-seed#[8954809E5D3BC698]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationOtherOp
   [junit4]   2> 3252478 INFO  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenVerify-seed#[8954809E5D3BC698]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenVerify
   [junit4]   2> 3252497 INFO  (qtp101561700-18581) [n:127.0.0.1:56198_solr    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=LIST&delegation=GgADYmFyA2JhcgCKAVd6aNfzigFXnnVb8wIEFHSbTeEyhDiFM_Q4pF1SUfqV874xB3NvbHItZHQA&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 3252497 INFO  (qtp101561700-18581) [n:127.0.0.1:56198_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=LIST&delegation=GgADYmFyA2JhcgCKAVd6aNfzigFXnnVb8wIEFHSbTeEyhDiFM_Q4pF1SUfqV874xB3NvbHItZHQA&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 3252501 WARN  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenVerify-seed#[8954809E5D3BC698]) [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=jue, 01-ene-1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: jue, 01-ene-1970 00:00:00 GMT
   [junit4]   2> 3252505 INFO  (qtp274585404-18572) [n:127.0.0.1:56193_solr    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=LIST&delegation=GgADYmFyA2JhcgCKAVd6aNfzigFXnnVb8wIEFHSbTeEyhDiFM_Q4pF1SUfqV874xB3NvbHItZHQA&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 3252505 INFO  (qtp274585404-18572) [n:127.0.0.1:56193_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=LIST&delegation=GgADYmFyA2JhcgCKAVd6aNfzigFXnnVb8wIEFHSbTeEyhDiFM_Q4pF1SUfqV874xB3NvbHItZHQA&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 3252508 WARN  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenVerify-seed#[8954809E5D3BC698]) [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=jue, 01-ene-1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: jue, 01-ene-1970 00:00:00 GMT
   [junit4]   2> 3252509 INFO  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenVerify-seed#[8954809E5D3BC698]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenVerify
   [junit4]   2> 3252541 INFO  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenewFail-seed#[8954809E5D3BC698]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenRenewFail
   [junit4]   2> 3252574 WARN  (qtp101561700-18586) [n:127.0.0.1:56198_solr    ] o.a.h.s.a.s.AuthenticationFilter Authentication exception: org.apache.hadoop.security.AccessControlException: foo tries to renew a token with renewer bar
   [junit4]   2> 3252574 WARN  (qtp101561700-18586) [n:127.0.0.1:56198_solr    ] o.a.s.s.KerberosPlugin Could not find org.apache.solr.security.kerberosplugin.requestcontinues
   [junit4]   2> 3252575 WARN  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenewFail-seed#[8954809E5D3BC698]) [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=jue, 01-ene-1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: jue, 01-ene-1970 00:00:00 GMT
   [junit4]   2> 3252577 WARN  (qtp274585404-18592) [    ] o.a.h.s.a.s.AuthenticationFilter Authentication exception: org.apache.hadoop.security.AccessControlException: foo tries to renew a token with renewer bar
   [junit4]   2> 3252578 WARN  (qtp274585404-18592) [    ] o.a.s.s.KerberosPlugin Could not find org.apache.solr.security.kerberosplugin.requestcontinues
   [junit4]   2> 3252579 WARN  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenewFail-seed#[8954809E5D3BC698]) [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=jue, 01-ene-1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: jue, 01-ene-1970 00:00:00 GMT
   [junit4]   2> 3252590 WARN  (qtp101561700-18586) [n:127.0.0.1:56198_solr    ] 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> 3252590 WARN  (qtp101561700-18586) [n:127.0.0.1:56198_solr    ] o.a.s.s.KerberosPlugin Could not find org.apache.solr.security.kerberosplugin.requestcontinues
   [junit4]   2> 3252591 WARN  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenewFail-seed#[8954809E5D3BC698]) [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=jue, 01-ene-1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: jue, 01-ene-1970 00:00:00 GMT
   [junit4]   2> 3252592 WARN  (qtp274585404-18579) [    ] 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> 3252592 WARN  (qtp274585404-18579) [    ] o.a.s.s.KerberosPlugin Could not find org.apache.solr.security.kerberosplugin.requestcontinues
   [junit4]   2> 3252592 WARN  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenewFail-seed#[8954809E5D3BC698]) [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=jue, 01-ene-1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: jue, 01-ene-1970 00:00:00 GMT
   [junit4]   2> 3252593 INFO  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenewFail-seed#[8954809E5D3BC698]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenRenewFail
   [junit4]   2> 3252627 INFO  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenSolrClient-seed#[8954809E5D3BC698]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenSolrClient
   [junit4]   2> 3252642 WARN  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenSolrClient-seed#[8954809E5D3BC698]) [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=jue, 01-ene-1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: jue, 01-ene-1970 00:00:00 GMT
   [junit4]   2> 3252649 INFO  (qtp101561700-18581) [n:127.0.0.1:56198_solr    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=LIST&delegation=GgADYmFyA2JhcgCKAVd6aNiJigFXnnVciQUEFNnik9iDOCehBAXRf_YAPbxX79DVB3NvbHItZHQA&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 3252649 INFO  (qtp101561700-18581) [n:127.0.0.1:56198_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=LIST&delegation=GgADYmFyA2JhcgCKAVd6aNiJigFXnnVciQUEFNnik9iDOCehBAXRf_YAPbxX79DVB3NvbHItZHQA&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 3252650 INFO  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenSolrClient-seed#[8954809E5D3BC698]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenSolrClient
   [junit4]   2> 3252688 INFO  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[8954809E5D3BC698]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenRenew
   [junit4]   2> 3252728 INFO  (qtp101561700-18586) [n:127.0.0.1:56198_solr    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=LIST&delegation=GgADYmFyA2JhcgCKAVd6aNjEigFXnnVcxAYEFEpA8Y6cys-2rwNn2AcXpdg3Fwz5B3NvbHItZHQA&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 3252728 INFO  (qtp101561700-18586) [n:127.0.0.1:56198_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=LIST&delegation=GgADYmFyA2JhcgCKAVd6aNjEigFXnnVcxAYEFEpA8Y6cys-2rwNn2AcXpdg3Fwz5B3NvbHItZHQA&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 3252731 WARN  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[8954809E5D3BC698]) [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=jue, 01-ene-1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: jue, 01-ene-1970 00:00:00 GMT
   [junit4]   2> 3252734 INFO  (qtp274585404-18579) [n:127.0.0.1:56193_solr    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=LIST&delegation=GgADYmFyA2JhcgCKAVd6aNjEigFXnnVcxAYEFEpA8Y6cys-2rwNn2AcXpdg3Fwz5B3NvbHItZHQA&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 3252734 INFO  (qtp274585404-18579) [n:127.0.0.1:56193_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=LIST&delegation=GgADYmFyA2JhcgCKAVd6aNjEigFXnnVcxAYEFEpA8Y6cys-2rwNn2AcXpdg3Fwz5B3NvbHItZHQA&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 3252737 WARN  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[8954809E5D3BC698]) [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=jue, 01-ene-1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: jue, 01-ene-1970 00:00:00 GMT
   [junit4]   2> 3252760 INFO  (qtp101561700-18585) [n:127.0.0.1:56198_solr    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=LIST&delegation=GgADYmFyA2JhcgCKAVd6aNj2igFXnnVc9gcEFLJIBurJlMTEsgxjyrEleldFT9bVB3NvbHItZHQA&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 3252761 INFO  (qtp101561700-18585) [n:127.0.0.1:56198_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=LIST&delegation=GgADYmFyA2JhcgCKAVd6aNj2igFXnnVc9gcEFLJIBurJlMTEsgxjyrEleldFT9bVB3NvbHItZHQA&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 3252764 WARN  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[8954809E5D3BC698]) [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=jue, 01-ene-1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: jue, 01-ene-1970 00:00:00 GMT
   [junit4]   2> 3252766 INFO  (qtp274585404-18575) [n:127.0.0.1:56193_solr    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=LIST&delegation=GgADYmFyA2JhcgCKAVd6aNj2igFXnnVc9gcEFLJIBurJlMTEsgxjyrEleldFT9bVB3NvbHItZHQA&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 3252766 INFO  (qtp274585404-18575) [n:127.0.0.1:56193_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=LIST&delegation=GgADYmFyA2JhcgCKAVd6aNj2igFXnnVc9gcEFLJIBurJlMTEsgxjyrEleldFT9bVB3NvbHItZHQA&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 3252770 WARN  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[8954809E5D3BC698]) [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=jue, 01-ene-1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: jue, 01-ene-1970 00:00:00 GMT
   [junit4]   2> 3252784 INFO  (qtp101561700-18585) [n:127.0.0.1:56198_solr    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=LIST&delegation=GgADYmFyA2JhcgCKAVd6aNkXigFXnnVdFwgEFDNGBfrP0Nb1YMxNrAC9BZkKjCtAB3NvbHItZHQA&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 3252784 INFO  (qtp101561700-18585) [n:127.0.0.1:56198_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=LIST&delegation=GgADYmFyA2JhcgCKAVd6aNkXigFXnnVdFwgEFDNGBfrP0Nb1YMxNrAC9BZkKjCtAB3NvbHItZHQA&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 3252788 WARN  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[8954809E5D3BC698]) [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=jue, 01-ene-1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: jue, 01-ene-1970 00:00:00 GMT
   [junit4]   2> 3252791 INFO  (qtp274585404-18578) [n:127.0.0.1:56193_solr    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=LIST&delegation=GgADYmFyA2JhcgCKAVd6aNkXigFXnnVdFwgEFDNGBfrP0Nb1YMxNrAC9BZkKjCtAB3NvbHItZHQA&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 3252791 INFO  (qtp274585404-18578) [n:127.0.0.1:56193_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=LIST&delegation=GgADYmFyA2JhcgCKAVd6aNkXigFXnnVdFwgEFDNGBfrP0Nb1YMxNrAC9BZkKjCtAB3NvbHItZHQA&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 3252794 WARN  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[8954809E5D3BC698]) [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=jue, 01-ene-1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: jue, 01-ene-1970 00:00:00 GMT
   [junit4]   2> 3252812 INFO  (qtp101561700-18585) [n:127.0.0.1:56198_solr    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=LIST&delegation=GgADYmFyA2JhcgCKAVd6aNkwigFXnnVdMAkEFB59ySte8HfGgVgIWMssPWd2xkJCB3NvbHItZHQA&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 3252812 INFO  (qtp101561700-18585) [n:127.0.0.1:56198_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=LIST&delegation=GgADYmFyA2JhcgCKAVd6aNkwigFXnnVdMAkEFB59ySte8HfGgVgIWMssPWd2xkJCB3NvbHItZHQA&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 3252815 WARN  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[8954809E5D3BC698]) [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=jue, 01-ene-1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: jue, 01-ene-1970 00:00:00 GMT
   [junit4]   2> 3252818 INFO  (qtp274585404-18574) [n:127.0.0.1:56193_solr    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=LIST&delegation=GgADYmFyA2JhcgCKAVd6aNkwigFXnnVdMAkEFB59ySte8HfGgVgIWMssPWd2xkJCB3NvbHItZHQA&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 3252818 INFO  (qtp274585404-18574) [n:127.0.0.1:56193_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=LIST&delegation=GgADYmFyA2JhcgCKAVd6aNkwigFXnnVdMAkEFB59ySte8HfGgVgIWMssPWd2xkJCB3NvbHItZHQA&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 3252822 WARN  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[8954809E5D3BC698]) [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=jue, 01-ene-1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: jue, 01-ene-1970 00:00:00 GMT
   [junit4]   2> 3252822 INFO  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[8954809E5D3BC698]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenRenew
   [junit4]   2> 3252843 INFO  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancelFail-seed#[8954809E5D3BC698]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenCancelFail
   [junit4]   2> 3252874 INFO  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancelFail-seed#[8954809E5D3BC698]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenCancelFail
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestSolrCloudWithDelegationTokens -Dtests.method=testDelegationTokenCancelFail -Dtests.seed=8954809E5D3BC698 -Dtests.slow=true -Dtests.locale=es-PY -Dtests.timezone=America/St_Kitts -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
   [junit4] FAILURE 0.06s J1 | TestSolrCloudWithDelegationTokens.testDelegationTokenCancelFail <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: expected:<200> but was:<404>
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([8954809E5D3BC698:E1EBB5B48DA1D474]:0)
   [junit4]    > 	at org.apache.solr.cloud.TestSolrCloudWithDelegationTokens.cancelDelegationToken(TestSolrCloudWithDelegationTokens.java:137)
   [junit4]    > 	at org.apache.solr.cloud.TestSolrCloudWithDelegationTokens.testDelegationTokenCancelFail(TestSolrCloudWithDelegationTokens.java:282)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 3252904 INFO  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[8954809E5D3BC698]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenCancel
   [junit4]   2> 3252920 ERROR (qtp101561700-18581) [n:127.0.0.1:56198_solr    ] o.a.h.s.t.d.ZKDelegationTokenSecretManager No node in path [/ZKDTSMTokensRoot/DT_11]
   [junit4]   2> 3252961 WARN  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[8954809E5D3BC698]) [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=jue, 01-ene-1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: jue, 01-ene-1970 00:00:00 GMT
   [junit4]   2> 3252964 WARN  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[8954809E5D3BC698]) [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=jue, 01-ene-1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: jue, 01-ene-1970 00:00:00 GMT
   [junit4]   2> 3252979 ERROR (qtp274585404-18574) [n:127.0.0.1:56193_solr    ] o.a.h.s.t.d.ZKDelegationTokenSecretManager No node in path [/ZKDTSMTokensRoot/DT_12]
   [junit4]   2> 3252985 WARN  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[8954809E5D3BC698]) [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=jue, 01-ene-1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: jue, 01-ene-1970 00:00:00 GMT
   [junit4]   2> 3252989 WARN  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[8954809E5D3BC698]) [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=jue, 01-ene-1970 00:00:00 GMT; HttpOnly". Invalid 'expires' attribute: jue, 01-ene-1970 00:00:00 GMT
   [junit4]   2> 3252989 INFO  (TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[8954809E5D3BC698]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenCancel
   [junit4]   2> 3252990 INFO  (jetty-launcher-3486-thread-2) [    ] o.e.j.s.ServerConnector Stopped ServerConnector@2e14a9e7{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 3252991 INFO  (jetty-launcher-3486-thread-1) [    ] o.e.j.s.ServerConnector Stopped ServerConnector@22522d8d{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 3252992 INFO  (jetty-launcher-3486-thread-2) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1534100905
   [junit4]   2> 3252993 INFO  (jetty-launcher-3486-thread-1) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1843941254
   [junit4]   2> 3252999 INFO  (jetty-launcher-3486-thread-2) [    ] o.a.s.c.Overseer Overseer (id=96680507498364933-127.0.0.1:56193_solr-n_0000000000) closing
   [junit4]   2> 3252999 INFO  (OverseerStateUpdate-96680507498364933-127.0.0.1:56193_solr-n_0000000000) [n:127.0.0.1:56193_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:56193_solr
   [junit4]   2> 3254503 WARN  (zkCallback-3496-thread-1-processing-n:127.0.0.1:56198_solr) [n:127.0.0.1:56198_solr    ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
   [junit4]   2> 3254503 WARN  (zkCallback-3497-thread-3-processing-n:127.0.0.1:56193_solr) [n:127.0.0.1:56193_solr    ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
   [junit4]   2> 3254503 ERROR (Thread[Thread-4379,5,TGRP-TestSolrCloudWithDelegationTokens]) [n:127.0.0.1:56198_solr    ] o.a.h.s.t.d.AbstractDelegationTokenSecretManager ExpiredTokenRemover received java.lang.InterruptedException: sleep interrupted
   [junit4]   2> 3254503 ERROR (Thread[Thread-4377,5,TGRP-TestSolrCloudWithDelegationTokens]) [n:127.0.0.1:56193_solr    ] o.a.h.s.t.d.AbstractDelegationTokenSecretManager ExpiredTokenRemover received java.lang.InterruptedException: sleep interrupted
   [junit4]   2> 3254540 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 0x1577a68ca250008, 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> 3254540 INFO  (jetty-launcher-3486-thread-2) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@4ea5bede{/solr,null,UNAVAILABLE}
   [junit4]   2> 3254541 INFO  (jetty-launcher-3486-thread-1) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@6fbd0df1{/solr,null,UNAVAILABLE}
   [junit4]   2> 3254546 INFO  (SUITE-TestSolrCloudWithDelegationTokens-seed#[8954809E5D3BC698]-worker) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:56189 56189
   [junit4]   2> 3254546 INFO  (Thread-4357) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:56189 56189
   [junit4]   2> 3254547 WARN  (Thread-4357) [    ] o.a.s.c.ZkTestServer Watch limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2> 	2	/solr/aliases.json
   [junit4]   2> 	2	/solr/security.json
   [junit4]   2> 	2	/solr/clusterprops.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2> 	4	/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMKeyIdRoot
   [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/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/ZKDTSMMasterKeyRoot/DK_2
   [junit4]   2> 	2	/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_2
   [junit4]   2> 	2	/solr/clusterstate.json
   [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/ZKDTSMTokensRoot/DT_12
   [junit4]   2> 	2	/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMSeqNumRoot
   [junit4]   2> 	2	/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_11
   [junit4]   2> 	2	/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_10
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2> 	3	/solr/overseer/queue
   [junit4]   2> 	3	/solr/overseer/collection-queue-work
   [junit4]   2> 	2	/solr/live_nodes
   [junit4]   2> 	2	/solr/collections
   [junit4]   2> 	2	/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot
   [junit4]   2> 	2	/solr/overseer/queue-work
   [junit4]   2> 	2	/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot
   [junit4]   2> 
   [junit4]   2> 3254548 INFO  (SUITE-TestSolrCloudWithDelegationTokens-seed#[8954809E5D3BC698]-worker) [    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestSolrCloudWithDelegationTokens_8954809E5D3BC698-001
   [junit4]   2> Sep 30, 2016 9:24:35 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 3 leaked thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene62): {}, docValues:{}, maxPointsInLeafNode=944, maxMBSortInHeap=7.102149706251738, sim=ClassicSimilarity, locale=es-PY, timezone=America/St_Kitts
   [junit4]   2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 1.8.0_102 (64-bit)/cpus=3,threads=1,free=143016368,total=500695040
   [junit4]   2> NOTE: All tests run in this JVM: [DateRangeFieldTest, TestRangeQuery, TestRestManager, SparseHLLTest, ZkSolrClientTest, ChaosMonkeySafeLeaderTest, TestDocSet, DistanceUnitsTest, TestFreeTextSuggestions, CachingDirectoryFactoryTest, TestCloudPivotFacet, BasicFunctionalityTest, DeleteLastCustomShardedReplicaTest, TestSlowCompositeReaderWrapper, TestFiltering, OverseerTaskQueueTest, RequestLoggingTest, TestConfigSets, HdfsRecoveryZkTest, SolrCoreCheckLockOnStartupTest, TestLegacyNumericRangeQueryBuilder, TestReload, BadComponentTest, ShardRoutingCustomTest, TestWriterPerf, BlockJoinFacetSimpleTest, DeleteStatusTest, TestJettySolrRunner, TermVectorComponentTest, TestSearchPerf, JSONWriterTest, TestExceedMaxTermLength, TestTrie, SuggestComponentContextFilterQueryTest, TestDownShardTolerantSearch, ConvertedLegacyTest, TestSolrXml, TestSolrQueryParserDefaultOperatorResource, TestStandardQParsers, BufferStoreTest, TestFieldCache, TestManagedResource, TestScoreJoinQPNoScore, TestLRUStatsCache, LeaderInitiatedRecoveryOnCommitTest, SliceStateTest, LeaderFailoverAfterPartitionTest, SpellCheckComponentTest, DistributedQueueTest, TestGeoJSONResponseWriter, FieldAnalysisRequestHandlerTest, DistributedFacetPivotWhiteBoxTest, CurrencyFieldOpenExchangeTest, TestLMJelinekMercerSimilarityFactory, CloneFieldUpdateProcessorFactoryTest, TestDistributedStatsComponentCardinality, BlobRepositoryCloudTest, TestSolrQueryParser, QueryParsingTest, BigEndianAscendingWordSerializerTest, PreAnalyzedFieldTest, TestUninvertingReader, TermVectorComponentDistributedTest, TestBulkSchemaConcurrent, DirectoryFactoryTest, RecoveryAfterSoftCommitTest, TestInitParams, CoreAdminCreateDiscoverTest, TestRequestForwarding, TestLuceneMatchVersion, AutoCommitTest, TestSolrConfigHandlerCloud, HdfsTlogReplayBufferedWhileIndexingTest, OverseerCollectionConfigSetProcessorTest, TestBadConfig, IgnoreCommitOptimizeUpdateProcessorFactoryTest, NoCacheHeaderTest, TestManagedSynonymFilterFactory, EchoParamsTest, PreAnalyzedUpdateProcessorTest, TestFilteredDocIdSet, SignatureUpdateProcessorFactoryTest, TestRandomCollapseQParserPlugin, HdfsWriteToMultipleCollectionsTest, TestReloadAndDeleteDocs, TestPHPSerializedResponseWriter, TestSolrIndexConfig, DataDrivenBlockJoinTest, HdfsDirectoryFactoryTest, TestSubQueryTransformerCrossCore, OpenCloseCoreStressTest, BooleanFieldTest, TestBlendedInfixSuggestions, TestJsonRequest, RuleEngineTest, AnalysisErrorHandlingTest, SolrXmlInZkTest, TestSolr4Spatial2, DistribDocExpirationUpdateProcessorTest, TestMinMaxOnMultiValuedField, TestQueryTypes, CloudExitableDirectoryReaderTest, TestCollectionAPI, AsyncCallRequestStatusResponseTest, TestDefaultStatsCache, DefaultValueUpdateProcessorTest, JsonLoaderTest, TestSolrDeletionPolicy2, DistanceFunctionTest, RAMDirectoryFactoryTest, TestReplicationHandlerBackup, TestSimpleQParserPlugin, TestCloudDeleteByQuery, BasicZkTest, TestCollationFieldDocValues, SuggesterTSTTest, OutOfBoxZkACLAndCredentialsProvidersTest, TestRecovery, SimpleMLTQParserTest, TestCustomSort, TestMiniSolrCloudCluster, SuggesterTest, TestSimpleTrackingShardHandler, EnumFieldTest, NotRequiredUniqueKeyTest, TestSuggestSpellingConverter, DebugComponentTest, TestMacroExpander, SecurityConfHandlerTest, HdfsChaosMonkeySafeLeaderTest, DistributedExpandComponentTest, TestFieldCacheWithThreads, TestRestoreCore, TestReversedWildcardFilterFactory, TestExactSharedStatsCache, TestIndexingPerformance, FileBasedSpellCheckerTest, SpellingQueryConverterTest, TestSystemIdResolver, TestNumericTerms32, TolerantUpdateProcessorTest, CursorMarkTest, DateMathParserTest, TestConfigReload, TestConfigSetImmutable, SolrCmdDistributorTest, TestOmitPositions, ScriptEngineTest, DistributedIntervalFacetingTest, TestClusterStateMutator, SSLMigrationTest, TestFieldCacheSanityChecker, VersionInfoTest, ExternalFileFieldSortTest, RecoveryZkTest, TestReplicationHandler, TestDistributedGrouping, TestHashPartitioner, DistributedSpellCheckComponentTest, TestStressReorder, TestJoin, SimpleFacetsTest, TestSolr4Spatial, StatsComponentTest, BadIndexSchemaTest, TestLazyCores, SoftAutoCommitTest, DistributedQueryElevationComponentTest, SpellCheckCollatorTest, SolrRequestParserTest, TestFoldingMultitermQuery, SuggesterWFSTTest, PolyFieldTest, WordBreakSolrSpellCheckerTest, SchemaVersionSpecificBehaviorTest, FieldMutatingUpdateProcessorTest, TestAtomicUpdateErrorCases, QueryEqualityTest, DirectUpdateHandlerOptimizeTest, SortByFunctionTest, TestRemoteStreaming, DocValuesMultiTest, CacheHeaderTest, IndexBasedSpellCheckerTest, LukeRequestHandlerTest, PrimitiveFieldTypeTest, RequestHandlersTest, PathHierarchyTokenizerFactoryTest, FastVectorHighlighterTest, IndexSchemaTest, ReturnFieldsTest, MBeansHandlerTest, UniqFieldsUpdateProcessorFactoryTest, CSVRequestHandlerTest, SearchHandlerTest, TestIBSimilarityFactory, TestJmxMonitoredMap, OpenExchangeRatesOrgProviderTest, PluginInfoTest, PrimUtilsTest, ClusterStateTest, UUIDFieldTest, TestDistributedMissingSort, TestEmbeddedSolrServerConstructors, AliasIntegrationTest, CdcrReplicationDistributedZkTest, CdcrRequestHandlerTest, CdcrVersionReplicationTest, CollectionStateFormat2Test, CollectionsAPISolrJTest, DeleteReplicaTest, DistribCursorPagingTest, DistributedVersionInfoTest, LeaderFailureAfterFreshStartTest, MigrateRouteKeyTest, MultiThreadedOCPTest, RemoteQueryErrorTest, ReplaceNodeTest, ShardSplitTest, TestRequestStatusCollectionAPI, TestSolrCloudWithDelegationTokens]
   [junit4] Completed [507/634 (1!)] on J1 in 5.90s, 8 tests, 1 failure <<< FAILURES!

[...truncated 60699 lines...]


Mime
View raw message