Build: http://jenkins.thetaphi.de/job/Lucene-Solr-master-Solaris/850/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseSerialGC
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([D8DD80530D1C30A6:B062B579DD86224A]: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 10553 lines...]
[junit4] Suite: org.apache.solr.cloud.TestSolrCloudWithDelegationTokens
[junit4] 2> Creating dataDir:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.TestSolrCloudWithDelegationTokens_D8DD80530D1C30A6-001/init-core-data-001
[junit4] 2> 141279 INFO
(SUITE-TestSolrCloudWithDelegationTokens-seed#[D8DD80530D1C30A6]-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> 141282 INFO
(SUITE-TestSolrCloudWithDelegationTokens-seed#[D8DD80530D1C30A6]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 141282 INFO (Thread-137) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 141282 INFO (Thread-137) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 141382 INFO
(SUITE-TestSolrCloudWithDelegationTokens-seed#[D8DD80530D1C30A6]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:43200
[junit4] 2> 141382 INFO
(SUITE-TestSolrCloudWithDelegationTokens-seed#[D8DD80530D1C30A6]-worker) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 141383 INFO
(SUITE-TestSolrCloudWithDelegationTokens-seed#[D8DD80530D1C30A6]-worker) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 141391 INFO (zkCallback-93-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@14c227ae
name:ZooKeeperConnection Watcher:127.0.0.1:43200 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 141391 INFO
(SUITE-TestSolrCloudWithDelegationTokens-seed#[D8DD80530D1C30A6]-worker) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 141391 INFO
(SUITE-TestSolrCloudWithDelegationTokens-seed#[D8DD80530D1C30A6]-worker) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 141391 INFO
(SUITE-TestSolrCloudWithDelegationTokens-seed#[D8DD80530D1C30A6]-worker) [ ]
o.a.s.c.c.SolrZkClient makePath: /solr/solr.xml
[junit4] 2> 141399 INFO (jetty-launcher-92-thread-1) [ ]
o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 141399 INFO (jetty-launcher-92-thread-2) [ ]
o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 141402 INFO (jetty-launcher-92-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@4f4e3f28{/solr,null,AVAILABLE}
[junit4] 2> 141404 INFO (jetty-launcher-92-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@144f03fe{/solr,null,AVAILABLE}
[junit4] 2> 141405 INFO (jetty-launcher-92-thread-1) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@3fd1897c{HTTP/1.1,[http/1.1]}{127.0.0.1:60137}
[junit4] 2> 141405 INFO (jetty-launcher-92-thread-1) [ ]
o.e.j.s.Server Started @144484ms
[junit4] 2> 141405 INFO (jetty-launcher-92-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=60137}
[junit4] 2> 141405 INFO (jetty-launcher-92-thread-2) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@4fc8d10f{HTTP/1.1,[http/1.1]}{127.0.0.1:41592}
[junit4] 2> 141405 INFO (jetty-launcher-92-thread-2) [ ]
o.e.j.s.Server Started @144485ms
[junit4] 2> 141405 INFO (jetty-launcher-92-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=41592}
[junit4] 2> 141405 INFO (jetty-launcher-92-thread-1) [ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@6d06d69c
[junit4] 2> 141405 INFO (jetty-launcher-92-thread-1) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.TestSolrCloudWithDelegationTokens_D8DD80530D1C30A6-001/tempDir-001/node1'
[junit4] 2> 141405 INFO (jetty-launcher-92-thread-2) [ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@6d06d69c
[junit4] 2> 141405 INFO (jetty-launcher-92-thread-1) [ ]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 141405 INFO (jetty-launcher-92-thread-1) [ ]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 141405 INFO (jetty-launcher-92-thread-2) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.TestSolrCloudWithDelegationTokens_D8DD80530D1C30A6-001/tempDir-001/node2'
[junit4] 2> 141406 INFO (jetty-launcher-92-thread-2) [ ]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 141406 INFO (jetty-launcher-92-thread-2) [ ]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 141406 INFO (jetty-launcher-92-thread-1) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 141406 INFO (jetty-launcher-92-thread-2) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 141406 INFO (jetty-launcher-92-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 141407 INFO (jetty-launcher-92-thread-2) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 141427 INFO (zkCallback-95-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@96a9db9 name:ZooKeeperConnection
Watcher:127.0.0.1:43200/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 141427 INFO (jetty-launcher-92-thread-2) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 141428 INFO (jetty-launcher-92-thread-2) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 141429 INFO (zkCallback-94-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@5a10eb78
name:ZooKeeperConnection Watcher:127.0.0.1:43200/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 141429 INFO (jetty-launcher-92-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 141429 INFO (jetty-launcher-92-thread-1) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 141429 INFO (jetty-launcher-92-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 141436 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 0x15736444c710001, 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> 141437 INFO (jetty-launcher-92-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 141448 INFO (jetty-launcher-92-thread-1) [ ]
o.a.s.c.CorePropertiesLocator Config-defined core root directory:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.TestSolrCloudWithDelegationTokens_D8DD80530D1C30A6-001/tempDir-001/node1/.
[junit4] 2> 141449 INFO (jetty-launcher-92-thread-1) [ ]
o.a.s.c.CoreContainer New CoreContainer 65160302
[junit4] 2> 141449 INFO (jetty-launcher-92-thread-1) [ ]
o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.TestSolrCloudWithDelegationTokens_D8DD80530D1C30A6-001/tempDir-001/node1]
[junit4] 2> 141449 WARN (jetty-launcher-92-thread-1) [ ]
o.a.s.c.CoreContainer Couldn't add files from
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.TestSolrCloudWithDelegationTokens_D8DD80530D1C30A6-001/tempDir-001/node1/lib
to classpath:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.TestSolrCloudWithDelegationTokens_D8DD80530D1C30A6-001/tempDir-001/node1/lib
[junit4] 2> 141449 INFO (jetty-launcher-92-thread-1) [ ]
o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme
: ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections :
10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime :
5,sizeOfQueue : -1,fairnessPolicy : false,
[junit4] 2> 141449 INFO (jetty-launcher-92-thread-2) [ ]
o.a.s.c.CorePropertiesLocator Config-defined core root directory:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.TestSolrCloudWithDelegationTokens_D8DD80530D1C30A6-001/tempDir-001/node2/.
[junit4] 2> 141449 INFO (jetty-launcher-92-thread-2) [ ]
o.a.s.c.CoreContainer New CoreContainer 1581723041
[junit4] 2> 141449 INFO (jetty-launcher-92-thread-2) [ ]
o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.TestSolrCloudWithDelegationTokens_D8DD80530D1C30A6-001/tempDir-001/node2]
[junit4] 2> 141449 WARN (jetty-launcher-92-thread-2) [ ]
o.a.s.c.CoreContainer Couldn't add files from
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.TestSolrCloudWithDelegationTokens_D8DD80530D1C30A6-001/tempDir-001/node2/lib
to classpath:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.TestSolrCloudWithDelegationTokens_D8DD80530D1C30A6-001/tempDir-001/node2/lib
[junit4] 2> 141450 INFO (jetty-launcher-92-thread-2) [ ]
o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme
: ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections :
10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime :
5,sizeOfQueue : -1,fairnessPolicy : false,
[junit4] 2> 141451 INFO (jetty-launcher-92-thread-1) [ ]
o.a.s.u.UpdateShardHandler Created UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&maxConnections=100000&maxConnectionsPerHost=100000
[junit4] 2> 141451 INFO (jetty-launcher-92-thread-1) [ ]
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 141451 INFO (jetty-launcher-92-thread-2) [ ]
o.a.s.u.UpdateShardHandler Created UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&maxConnections=100000&maxConnectionsPerHost=100000
[junit4] 2> 141451 INFO (jetty-launcher-92-thread-1) [ ]
o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 141451 INFO (jetty-launcher-92-thread-2) [ ]
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 141451 INFO (jetty-launcher-92-thread-2) [ ]
o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 141451 INFO (jetty-launcher-92-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43200/solr
[junit4] 2> 141461 INFO (jetty-launcher-92-thread-1) [ ]
o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 141461 INFO (jetty-launcher-92-thread-1) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 141461 INFO (jetty-launcher-92-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43200/solr
[junit4] 2> 141461 INFO (jetty-launcher-92-thread-2) [ ]
o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 141462 INFO (jetty-launcher-92-thread-2) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 141462 INFO (jetty-launcher-92-thread-2) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 141463 INFO (jetty-launcher-92-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 141484 INFO (zkCallback-101-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@4b27874f
name:ZooKeeperConnection Watcher:127.0.0.1:43200 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 141484 INFO (jetty-launcher-92-thread-2) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 141484 INFO (jetty-launcher-92-thread-2) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 141488 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_solr ] o.a.s.c.ZkController Added new OnReconnect
listener org.apache.solr.cloud.ZkController$$Lambda$9/69896165@21b7cfd6
[junit4] 2> 141489 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 141495 INFO (zkCallback-100-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@350ea70e
name:ZooKeeperConnection Watcher:127.0.0.1:43200 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 141495 INFO (jetty-launcher-92-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 141496 INFO (jetty-launcher-92-thread-1) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 141531 INFO
(zkCallback-102-thread-1-processing-n:127.0.0.1:41592_solr)
[n:127.0.0.1:41592_solr ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@5425ffa0
name:ZooKeeperConnection Watcher:127.0.0.1:43200/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 141531 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_solr ] o.a.s.c.c.ConnectionManager Client is connected to
ZooKeeper
[junit4] 2> 141532 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.ZkController Added new OnReconnect
listener org.apache.solr.cloud.ZkController$$Lambda$9/69896165@6b5b6e3d
[junit4] 2> 141532 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 141563 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 141567 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-queue-work
[junit4] 2> 141602 INFO
(zkCallback-103-thread-1-processing-n:127.0.0.1:60137_solr)
[n:127.0.0.1:60137_solr ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@4d962278
name:ZooKeeperConnection Watcher:127.0.0.1:43200/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 141603 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.c.ConnectionManager Client is connected to
ZooKeeper
[junit4] 2> 141603 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-running
[junit4] 2> 141624 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-completed
[junit4] 2> 141625 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-completed
[junit4] 2> 141653 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-failure
[junit4] 2> 141654 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-failure
[junit4] 2> 141655 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 141656 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 141657 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 141658 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 141659 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_solr ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 141660 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 141660 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_solr ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 141661 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 141662 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_solr ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 141662 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.c.ZkStateReader Updating cluster state
from ZooKeeper...
[junit4] 2> 141663 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.c.ZkStateReader Loaded empty cluster
properties
[junit4] 2> 141663 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_solr ] o.a.s.c.c.ZkStateReader Updating cluster state
from ZooKeeper...
[junit4] 2> 141664 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (0)
[junit4] 2> 141664 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_solr ] o.a.s.c.c.ZkStateReader Loaded empty cluster
properties
[junit4] 2> 141666 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (0)
[junit4] 2> 141668 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 141669 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/election
[junit4] 2> 141671 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 141671 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 141672 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.LeaderElector Joined leadership election
with path:
/overseer_elect/election/96605583979905030-127.0.0.1:60137_solr-n_0000000000
[junit4] 2> 141672 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_solr ] o.a.s.c.LeaderElector Joined leadership election
with path:
/overseer_elect/election/96605583979905029-127.0.0.1:41592_solr-n_0000000001
[junit4] 2> 141672 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:60137_solr
[junit4] 2> 141672 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/leader
[junit4] 2> 141673 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_solr ] o.a.s.c.LeaderElector Watching path
/overseer_elect/election/96605583979905030-127.0.0.1:60137_solr-n_0000000000 to
know if I could be the leader
[junit4] 2> 141674 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.Overseer Overseer
(id=96605583979905030-127.0.0.1:60137_solr-n_0000000000) starting
[junit4] 2> 141674 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:41592_solr
[junit4] 2> 141674 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_solr ] o.a.s.c.c.SolrZkClient makePath:
/live_nodes/127.0.0.1:41592_solr
[junit4] 2> 141676 INFO
(zkCallback-103-thread-1-processing-n:127.0.0.1:60137_solr)
[n:127.0.0.1:60137_solr ] o.a.s.c.c.ZkStateReader A live node change:
[WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes],
has occurred - updating... (live nodes size: [0])
[junit4] 2> 141676 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.c.SolrZkClient makePath:
/overseer/queue-work
[junit4] 2> 141683 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=30000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 141684 INFO
(OverseerCollectionConfigSetProcessor-96605583979905030-127.0.0.1:60137_solr-n_0000000000)
[n:127.0.0.1:60137_solr ] o.a.s.c.OverseerTaskProcessor Process current
queue of overseer operations
[junit4] 2> 141685 INFO
(OverseerStateUpdate-96605583979905030-127.0.0.1:60137_solr-n_0000000000)
[n:127.0.0.1:60137_solr ] o.a.s.c.Overseer Starting to work on the main queue
[junit4] 2> 141685 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.ZkController Publish
node=127.0.0.1:60137_solr as DOWN
[junit4] 2> 141687 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:60137_solr
[junit4] 2> 141687 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.c.SolrZkClient makePath:
/live_nodes/127.0.0.1:60137_solr
[junit4] 2> 141689 INFO
(zkCallback-103-thread-2-processing-n:127.0.0.1:60137_solr)
[n:127.0.0.1:60137_solr ] o.a.s.c.c.ZkStateReader A live node change:
[WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes],
has occurred - updating... (live nodes size: [0])
[junit4] 2> 141706 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_solr ] o.a.s.c.CoreContainer Security conf doesn't exist.
Skipping setup for authorization module.
[junit4] 2> 141706 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_solr ] o.a.s.c.CoreContainer Authentication plugin class
obtained from system property 'authenticationPlugin':
org.apache.solr.security.HttpParamDelegationTokenPlugin
[junit4] 2> 141721 INFO
(zkCallback-102-thread-1-processing-n:127.0.0.1:41592_solr)
[n:127.0.0.1:41592_solr ] o.a.s.c.c.ZkStateReader A live node change:
[WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes],
has occurred - updating... (live nodes size: [0])
[junit4] 2> 141729 INFO
(zkCallback-103-thread-1-processing-n:127.0.0.1:60137_solr)
[n:127.0.0.1:60137_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 141730 INFO
(zkCallback-102-thread-1-processing-n:127.0.0.1:41592_solr)
[n:127.0.0.1:41592_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 141731 INFO
(OverseerStateUpdate-96605583979905030-127.0.0.1:60137_solr-n_0000000000)
[n:127.0.0.1:60137_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (2)
[junit4] 2> 141732 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_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> 141732 INFO
(OverseerStateUpdate-96605583979905030-127.0.0.1:60137_solr-n_0000000000)
[n:127.0.0.1:60137_solr ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "operation":"downnode",
[junit4] 2> "node_name":"127.0.0.1:60137_solr"} current state version: 0
[junit4] 2> 141732 INFO
(OverseerStateUpdate-96605583979905030-127.0.0.1:60137_solr-n_0000000000)
[n:127.0.0.1:60137_solr ] o.a.s.c.o.NodeMutator DownNode state invoked for
node: 127.0.0.1:60137_solr
[junit4] 2> 141765 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.CoreContainer Security conf doesn't exist.
Skipping setup for authorization module.
[junit4] 2> 141765 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.CoreContainer Authentication plugin class
obtained from system property 'authenticationPlugin':
org.apache.solr.security.HttpParamDelegationTokenPlugin
[junit4] 2> 141765 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_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> 141882 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_solr ] o.a.c.f.i.CuratorFrameworkImpl Starting
[junit4] 2> 141882 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.c.f.i.CuratorFrameworkImpl Starting
[junit4] 2> 141904 INFO (jetty-launcher-92-thread-1-EventThread)
[n:127.0.0.1:60137_solr ] o.a.c.f.s.ConnectionStateManager State change:
CONNECTED
[junit4] 2> 141906 INFO (jetty-launcher-92-thread-2-EventThread)
[n:127.0.0.1:41592_solr ] o.a.c.f.s.ConnectionStateManager State change:
CONNECTED
[junit4] 2> 142348 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.CoreContainer Reconfiguring HttpClient
settings.
[junit4] 2> 142349 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.CorePropertiesLocator Looking for core
definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.TestSolrCloudWithDelegationTokens_D8DD80530D1C30A6-001/tempDir-001/node1/.
[junit4] 2> 142349 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions
[junit4] 2> 142353 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.s.SolrDispatchFilter
user.dir=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0
[junit4] 2> 142353 INFO (jetty-launcher-92-thread-1)
[n:127.0.0.1:60137_solr ] o.a.s.s.SolrDispatchFilter
SolrDispatchFilter.init() done
[junit4] 2> 142353 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_solr ] o.a.s.c.CoreContainer Reconfiguring HttpClient
settings.
[junit4] 2> 142354 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_solr ] o.a.s.c.CorePropertiesLocator Looking for core
definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.TestSolrCloudWithDelegationTokens_D8DD80530D1C30A6-001/tempDir-001/node2/.
[junit4] 2> 142354 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions
[junit4] 2> 142355 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_solr ] o.a.s.s.SolrDispatchFilter
user.dir=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0
[junit4] 2> 142355 INFO (jetty-launcher-92-thread-2)
[n:127.0.0.1:41592_solr ] o.a.s.s.SolrDispatchFilter
SolrDispatchFilter.init() done
[junit4] 2> 142356 INFO
(SUITE-TestSolrCloudWithDelegationTokens-seed#[D8DD80530D1C30A6]-worker) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 142357 INFO
(SUITE-TestSolrCloudWithDelegationTokens-seed#[D8DD80530D1C30A6]-worker) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 142373 INFO (zkCallback-106-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@5b06e3c6
name:ZooKeeperConnection Watcher:127.0.0.1:43200 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 142373 INFO
(SUITE-TestSolrCloudWithDelegationTokens-seed#[D8DD80530D1C30A6]-worker) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 142374 INFO
(SUITE-TestSolrCloudWithDelegationTokens-seed#[D8DD80530D1C30A6]-worker) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 142404 INFO
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[D8DD80530D1C30A6])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenCancel
[junit4] 2> 143903 ERROR (qtp1229696869-788) [ ]
o.a.h.s.t.d.ZKDelegationTokenSecretManager No node in path
[/ZKDTSMTokensRoot/DT_1]
[junit4] 2> 143953 WARN
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[D8DD80530D1C30A6])
[ ] 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> 143967 WARN
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[D8DD80530D1C30A6])
[ ] 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> 143997 ERROR (qtp806429949-791) [ ]
o.a.h.s.t.d.ZKDelegationTokenSecretManager No node in path
[/ZKDTSMTokensRoot/DT_2]
[junit4] 2> 144009 WARN
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[D8DD80530D1C30A6])
[ ] 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> 144015 WARN
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[D8DD80530D1C30A6])
[ ] 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> 144016 INFO
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[D8DD80530D1C30A6])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenCancel
[junit4] 2> 144056 INFO
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenewFail-seed#[D8DD80530D1C30A6])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenRenewFail
[junit4] 2> 144090 WARN (qtp1229696869-786) [ ]
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> 144090 WARN (qtp1229696869-786) [ ] o.a.s.s.KerberosPlugin
Could not find org.apache.solr.security.kerberosplugin.requestcontinues
[junit4] 2> 144094 WARN
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenewFail-seed#[D8DD80530D1C30A6])
[ ] 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> 144096 WARN (qtp806429949-798) [ ]
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> 144096 WARN (qtp806429949-798) [ ] o.a.s.s.KerberosPlugin
Could not find org.apache.solr.security.kerberosplugin.requestcontinues
[junit4] 2> 144097 WARN
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenewFail-seed#[D8DD80530D1C30A6])
[ ] 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> 144115 WARN (qtp1229696869-787) [ ]
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> 144115 WARN (qtp1229696869-787) [ ] o.a.s.s.KerberosPlugin
Could not find org.apache.solr.security.kerberosplugin.requestcontinues
[junit4] 2> 144116 WARN
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenewFail-seed#[D8DD80530D1C30A6])
[ ] 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> 144116 WARN (qtp806429949-791) [ ]
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> 144117 WARN (qtp806429949-791) [ ] o.a.s.s.KerberosPlugin
Could not find org.apache.solr.security.kerberosplugin.requestcontinues
[junit4] 2> 144118 WARN
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenewFail-seed#[D8DD80530D1C30A6])
[ ] 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> 144118 INFO
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenewFail-seed#[D8DD80530D1C30A6])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenRenewFail
[junit4] 2> 144159 INFO
(TEST-TestSolrCloudWithDelegationTokens.testZNodePaths-seed#[D8DD80530D1C30A6])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testZNodePaths
[junit4] 2> 144168 INFO
(TEST-TestSolrCloudWithDelegationTokens.testZNodePaths-seed#[D8DD80530D1C30A6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 144169 INFO
(TEST-TestSolrCloudWithDelegationTokens.testZNodePaths-seed#[D8DD80530D1C30A6])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 144172 INFO (zkCallback-108-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@11d1bd21
name:ZooKeeperConnection Watcher:127.0.0.1:43200/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 144172 INFO
(TEST-TestSolrCloudWithDelegationTokens.testZNodePaths-seed#[D8DD80530D1C30A6])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 144173 INFO
(TEST-TestSolrCloudWithDelegationTokens.testZNodePaths-seed#[D8DD80530D1C30A6])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 144175 INFO
(TEST-TestSolrCloudWithDelegationTokens.testZNodePaths-seed#[D8DD80530D1C30A6])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testZNodePaths
[junit4] 2> 144227 INFO
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancelFail-seed#[D8DD80530D1C30A6])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenCancelFail
[junit4] 2> 144253 INFO
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancelFail-seed#[D8DD80530D1C30A6])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenCancelFail
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=TestSolrCloudWithDelegationTokens
-Dtests.method=testDelegationTokenCancelFail -Dtests.seed=D8DD80530D1C30A6
-Dtests.slow=true -Dtests.locale=es-VE -Dtests.timezone=Africa/Malabo
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 0.09s J0 |
TestSolrCloudWithDelegationTokens.testDelegationTokenCancelFail <<<
[junit4] > Throwable #1: java.lang.AssertionError: expected:<200> but
was:<404>
[junit4] > at
__randomizedtesting.SeedInfo.seed([D8DD80530D1C30A6:B062B579DD86224A]: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> 144287 INFO
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[D8DD80530D1C30A6])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenRenew
[junit4] 2> 144327 INFO (qtp1229696869-787) [n:127.0.0.1:60137_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params
action=LIST&delegation=GgADYmFyA2JhcgCKAVc2RFgtigFXWlDcLQcDFJbcuO9mQ2VCoisJeQA_nGkDqIcIB3NvbHItZHQA&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 144327 INFO (qtp1229696869-787) [n:127.0.0.1:60137_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVc2RFgtigFXWlDcLQcDFJbcuO9mQ2VCoisJeQA_nGkDqIcIB3NvbHItZHQA&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 144331 WARN
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[D8DD80530D1C30A6])
[ ] 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> 144334 INFO (qtp806429949-784) [n:127.0.0.1:41592_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params
action=LIST&delegation=GgADYmFyA2JhcgCKAVc2RFgtigFXWlDcLQcDFJbcuO9mQ2VCoisJeQA_nGkDqIcIB3NvbHItZHQA&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 144334 INFO (qtp806429949-784) [n:127.0.0.1:41592_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVc2RFgtigFXWlDcLQcDFJbcuO9mQ2VCoisJeQA_nGkDqIcIB3NvbHItZHQA&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 144337 WARN
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[D8DD80530D1C30A6])
[ ] 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> 144379 INFO (qtp1229696869-788) [n:127.0.0.1:60137_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params
action=LIST&delegation=GgADYmFyA2JhcgCKAVc2RFhfigFXWlDcXwgDFLshG7UcpwC9iU_CtHuHp14UbomBB3NvbHItZHQA&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 144379 INFO (qtp1229696869-788) [n:127.0.0.1:60137_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVc2RFhfigFXWlDcXwgDFLshG7UcpwC9iU_CtHuHp14UbomBB3NvbHItZHQA&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 144388 WARN
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[D8DD80530D1C30A6])
[ ] 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> 144393 INFO (qtp806429949-798) [n:127.0.0.1:41592_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params
action=LIST&delegation=GgADYmFyA2JhcgCKAVc2RFhfigFXWlDcXwgDFLshG7UcpwC9iU_CtHuHp14UbomBB3NvbHItZHQA&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 144393 INFO (qtp806429949-798) [n:127.0.0.1:41592_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVc2RFhfigFXWlDcXwgDFLshG7UcpwC9iU_CtHuHp14UbomBB3NvbHItZHQA&wt=javabin&version=2}
status=0 QTime=1
[junit4] 2> 144398 WARN
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[D8DD80530D1C30A6])
[ ] 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> 144431 INFO (qtp1229696869-785) [n:127.0.0.1:60137_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params
action=LIST&delegation=GgADYmFyA2JhcgCKAVc2RFicigFXWlDcnAkDFKbxfEptayZOmJ4RUpiJkQ3kLLgzB3NvbHItZHQA&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 144431 INFO (qtp1229696869-785) [n:127.0.0.1:60137_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVc2RFicigFXWlDcnAkDFKbxfEptayZOmJ4RUpiJkQ3kLLgzB3NvbHItZHQA&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 144435 WARN
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[D8DD80530D1C30A6])
[ ] 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> 144438 INFO (qtp806429949-784) [n:127.0.0.1:41592_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params
action=LIST&delegation=GgADYmFyA2JhcgCKAVc2RFicigFXWlDcnAkDFKbxfEptayZOmJ4RUpiJkQ3kLLgzB3NvbHItZHQA&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 144438 INFO (qtp806429949-784) [n:127.0.0.1:41592_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVc2RFicigFXWlDcnAkDFKbxfEptayZOmJ4RUpiJkQ3kLLgzB3NvbHItZHQA&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 144442 WARN
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[D8DD80530D1C30A6])
[ ] 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> 144460 INFO (qtp1229696869-787) [n:127.0.0.1:60137_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params
action=LIST&delegation=GgADYmFyA2JhcgCKAVc2RFjIigFXWlDcyAoDFI-bJC4iaqPofPK_ZYsaP0n1qnxVB3NvbHItZHQA&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 144460 INFO (qtp1229696869-787) [n:127.0.0.1:60137_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVc2RFjIigFXWlDcyAoDFI-bJC4iaqPofPK_ZYsaP0n1qnxVB3NvbHItZHQA&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 144465 WARN
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[D8DD80530D1C30A6])
[ ] 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> 144490 INFO (qtp806429949-794) [n:127.0.0.1:41592_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params
action=LIST&delegation=GgADYmFyA2JhcgCKAVc2RFjIigFXWlDcyAoDFI-bJC4iaqPofPK_ZYsaP0n1qnxVB3NvbHItZHQA&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 144490 INFO (qtp806429949-794) [n:127.0.0.1:41592_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVc2RFjIigFXWlDcyAoDFI-bJC4iaqPofPK_ZYsaP0n1qnxVB3NvbHItZHQA&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 144494 WARN
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[D8DD80530D1C30A6])
[ ] 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> 144494 INFO
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[D8DD80530D1C30A6])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenRenew
[junit4] 2> 144518 INFO
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenVerify-seed#[D8DD80530D1C30A6])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenVerify
[junit4] 2> 144528 INFO (qtp1229696869-790) [n:127.0.0.1:60137_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params
action=LIST&delegation=GgADYmFyA2JhcgCKAVc2RFkTigFXWlDdEwsDFGQe_Uby6CFbZX1Plh8p3svnLFVaB3NvbHItZHQA&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 144528 INFO (qtp1229696869-790) [n:127.0.0.1:60137_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVc2RFkTigFXWlDdEwsDFGQe_Uby6CFbZX1Plh8p3svnLFVaB3NvbHItZHQA&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 144534 WARN
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenVerify-seed#[D8DD80530D1C30A6])
[ ] 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> 144538 INFO (qtp806429949-796) [n:127.0.0.1:41592_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params
action=LIST&delegation=GgADYmFyA2JhcgCKAVc2RFkTigFXWlDdEwsDFGQe_Uby6CFbZX1Plh8p3svnLFVaB3NvbHItZHQA&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 144538 INFO (qtp806429949-796) [n:127.0.0.1:41592_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVc2RFkTigFXWlDdEwsDFGQe_Uby6CFbZX1Plh8p3svnLFVaB3NvbHItZHQA&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 144544 WARN
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenVerify-seed#[D8DD80530D1C30A6])
[ ] 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> 144544 INFO
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenVerify-seed#[D8DD80530D1C30A6])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenVerify
[junit4] 2> 144568 INFO
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenSolrClient-seed#[D8DD80530D1C30A6])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenSolrClient
[junit4] 2> 144584 WARN
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenSolrClient-seed#[D8DD80530D1C30A6])
[ ] 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> 144588 INFO (qtp1229696869-783) [n:127.0.0.1:60137_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params
action=LIST&delegation=GgADYmFyA2JhcgCKAVc2RFlGigFXWlDdRgwDFD9X4dOYfdJbJSJss4PL3pJEfJ1ZB3NvbHItZHQA&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 144588 INFO (qtp1229696869-783) [n:127.0.0.1:60137_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVc2RFlGigFXWlDdRgwDFD9X4dOYfdJbJSJss4PL3pJEfJ1ZB3NvbHItZHQA&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 144589 INFO
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenSolrClient-seed#[D8DD80530D1C30A6])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenSolrClient
[junit4] 2> 144611 INFO
(TEST-TestSolrCloudWithDelegationTokens.testDelegationOtherOp-seed#[D8DD80530D1C30A6])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationOtherOp
[junit4] 2> 144615 INFO (qtp1229696869-789) [n:127.0.0.1:60137_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> 144616 INFO (qtp1229696869-789) [n:127.0.0.1:60137_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> 144616 WARN
(TEST-TestSolrCloudWithDelegationTokens.testDelegationOtherOp-seed#[D8DD80530D1C30A6])
[ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth="u=bar&p=bar&t=test&e=1474120231539&s=p6UkuY102t8YkyGAp+sCBQn2jDY=";
Path=/; Domain=127.0.0.1; Expires=sáb, 17-sep-2016 13:50:31 GMT; HttpOnly".
Invalid 'expires' attribute: sáb, 17-sep-2016 13:50:31 GMT
[junit4] 2> 144619 INFO
(TEST-TestSolrCloudWithDelegationTokens.testDelegationOtherOp-seed#[D8DD80530D1C30A6])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationOtherOp
[junit4] 2> 144622 INFO (jetty-launcher-92-thread-1) [ ]
o.e.j.s.ServerConnector Stopped
ServerConnector@4fc8d10f{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 144622 INFO (jetty-launcher-92-thread-2) [ ]
o.e.j.s.ServerConnector Stopped
ServerConnector@3fd1897c{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 144622 INFO (jetty-launcher-92-thread-1) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1581723041
[junit4] 2> 144622 INFO (jetty-launcher-92-thread-2) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=65160302
[junit4] 2> 144623 INFO (jetty-launcher-92-thread-1) [ ]
o.a.s.c.ZkController Publish node=127.0.0.1:41592_solr as DOWN
[junit4] 2> 144623 INFO (jetty-launcher-92-thread-2) [ ]
o.a.s.c.ZkController Publish node=127.0.0.1:60137_solr as DOWN
[junit4] 2> 144627 INFO (jetty-launcher-92-thread-2) [ ]
o.a.s.c.Overseer Overseer
(id=96605583979905030-127.0.0.1:60137_solr-n_0000000000) closing
[junit4] 2> 144627 INFO
(OverseerStateUpdate-96605583979905030-127.0.0.1:60137_solr-n_0000000000)
[n:127.0.0.1:60137_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:60137_solr
[junit4] 2> 144631 INFO
(zkCallback-103-thread-3-processing-n:127.0.0.1:60137_solr)
[n:127.0.0.1:60137_solr ] o.a.s.c.c.ZkStateReader A live node change:
[WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes],
has occurred - updating... (live nodes size: [2])
[junit4] 2> 144632 WARN
(zkCallback-103-thread-3-processing-n:127.0.0.1:60137_solr)
[n:127.0.0.1:60137_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 144632 INFO
(zkCallback-102-thread-2-processing-n:127.0.0.1:41592_solr)
[n:127.0.0.1:41592_solr ] o.a.s.c.c.ZkStateReader A live node change:
[WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes],
has occurred - updating... (live nodes size: [2])
[junit4] 2> 144631 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 0x15736444c710006, 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> 144632 WARN
(zkCallback-102-thread-2-processing-n:127.0.0.1:41592_solr)
[n:127.0.0.1:41592_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 144633 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 0x15736444c710005, 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> 144633 ERROR
(Thread[Thread-157,5,TGRP-TestSolrCloudWithDelegationTokens])
[n:127.0.0.1:41592_solr ] o.a.h.s.t.d.AbstractDelegationTokenSecretManager
ExpiredTokenRemover received java.lang.InterruptedException: sleep interrupted
[junit4] 2> 144633 ERROR
(Thread[Thread-154,5,TGRP-TestSolrCloudWithDelegationTokens])
[n:127.0.0.1:60137_solr ] o.a.h.s.t.d.AbstractDelegationTokenSecretManager
ExpiredTokenRemover received java.lang.InterruptedException: sleep interrupted
[junit4] 2> 144654 INFO (jetty-launcher-92-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@144f03fe{/solr,null,UNAVAILABLE}
[junit4] 2> 144655 INFO (jetty-launcher-92-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@4f4e3f28{/solr,null,UNAVAILABLE}
[junit4] 2> 144657 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 0x15736444c710008, 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> 144662 INFO
(SUITE-TestSolrCloudWithDelegationTokens-seed#[D8DD80530D1C30A6]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:43200 43200
[junit4] 2> 144788 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxnFactory Ignoring unexpected runtime exception
[junit4] 2> java.nio.channels.CancelledKeyException
[junit4] 2> at
sun.nio.ch.SelectionKeyImpl.ensureValid(SelectionKeyImpl.java:73)
[junit4] 2> at
sun.nio.ch.SelectionKeyImpl.readyOps(SelectionKeyImpl.java:87)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:187)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 144790 INFO (Thread-137) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:43200 43200
[junit4] 2> 144792 WARN (Thread-137) [ ] 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> 3 /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/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> 144793 INFO
(SUITE-TestSolrCloudWithDelegationTokens-seed#[D8DD80530D1C30A6]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.TestSolrCloudWithDelegationTokens_D8DD80530D1C30A6-001
[junit4] 2> Sep 17, 2016 3:50:31 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62): {},
docValues:{}, maxPointsInLeafNode=1408, maxMBSortInHeap=5.854109820729404,
sim=RandomSimilarity(queryNorm=true): {}, locale=es-VE, timezone=Africa/Malabo
[junit4] 2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_102
(64-bit)/cpus=3,threads=1,free=39415216,total=143806464
[junit4] 2> NOTE: All tests run in this JVM:
[LeaderInitiatedRecoveryOnCommitTest, UnloadDistributedZkTest,
TestSolrCloudWithDelegationTokens]
[junit4] Completed [33/631 (1!)] on J0 in 4.04s, 8 tests, 1 failure <<<
FAILURES!
[...truncated 62134 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org
