Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Solaris/1441/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseG1GC
1 tests failed.
FAILED:
org.apache.solr.security.hadoop.TestDelegationWithHadoopAuth.testDelegationTokenRenew
Error Message:
expected:<200> but was:<403>
Stack Trace:
java.lang.AssertionError: expected:<200> but was:<403>
at
__randomizedtesting.SeedInfo.seed([BC42AB722013EF1D:8BD95F6C18DF32B9]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at
org.apache.solr.security.hadoop.TestDelegationWithHadoopAuth.renewDelegationToken(TestDelegationWithHadoopAuth.java:118)
at
org.apache.solr.security.hadoop.TestDelegationWithHadoopAuth.verifyDelegationTokenRenew(TestDelegationWithHadoopAuth.java:302)
at
org.apache.solr.security.hadoop.TestDelegationWithHadoopAuth.testDelegationTokenRenew(TestDelegationWithHadoopAuth.java:319)
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:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 11628 lines...]
[junit4] Suite: org.apache.solr.security.hadoop.TestDelegationWithHadoopAuth
[junit4] 2> 727251 INFO
(SUITE-TestDelegationWithHadoopAuth-seed#[BC42AB722013EF1D]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.security.hadoop.TestDelegationWithHadoopAuth_BC42AB722013EF1D-001/init-core-data-001
[junit4] 2> 727251 WARN
(SUITE-TestDelegationWithHadoopAuth-seed#[BC42AB722013EF1D]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=3 numCloses=3
[junit4] 2> 727252 INFO
(SUITE-TestDelegationWithHadoopAuth-seed#[BC42AB722013EF1D]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 727254 INFO
(SUITE-TestDelegationWithHadoopAuth-seed#[BC42AB722013EF1D]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 727256 INFO
(SUITE-TestDelegationWithHadoopAuth-seed#[BC42AB722013EF1D]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.security.hadoop.TestDelegationWithHadoopAuth_BC42AB722013EF1D-001/tempDir-001
[junit4] 2> 727256 INFO
(SUITE-TestDelegationWithHadoopAuth-seed#[BC42AB722013EF1D]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 727256 INFO (Thread-1355) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 727256 INFO (Thread-1355) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 727259 ERROR (Thread-1355) [ ] o.a.z.s.ZooKeeperServer
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action
on ERROR or SHUTDOWN server state changes
[junit4] 2> 727356 INFO
(SUITE-TestDelegationWithHadoopAuth-seed#[BC42AB722013EF1D]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:33022
[junit4] 2> 727402 INFO (jetty-launcher-937-thread-1) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 727404 INFO (jetty-launcher-937-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@29a5da93{/solr,null,AVAILABLE}
[junit4] 2> 727405 INFO (jetty-launcher-937-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@9a32663{SSL,[ssl,
http/1.1]}{127.0.0.1:48897}
[junit4] 2> 727405 INFO (jetty-launcher-937-thread-1) [ ]
o.e.j.s.Server Started @729908ms
[junit4] 2> 727405 INFO (jetty-launcher-937-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=48897}
[junit4] 2> 727406 ERROR (jetty-launcher-937-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 727406 INFO (jetty-launcher-937-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 727406 INFO (jetty-launcher-937-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 727406 INFO (jetty-launcher-937-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 727406 INFO (jetty-launcher-937-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-09-28T21:28:13.856Z
[junit4] 2> 727410 INFO (jetty-launcher-937-thread-2) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 727411 INFO (jetty-launcher-937-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 727412 INFO (jetty-launcher-937-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@36871ca{/solr,null,AVAILABLE}
[junit4] 2> 727413 INFO (jetty-launcher-937-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@4fa4db54{SSL,[ssl,
http/1.1]}{127.0.0.1:38625}
[junit4] 2> 727413 INFO (jetty-launcher-937-thread-2) [ ]
o.e.j.s.Server Started @729915ms
[junit4] 2> 727413 INFO (jetty-launcher-937-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=38625}
[junit4] 2> 727413 ERROR (jetty-launcher-937-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 727413 INFO (jetty-launcher-937-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 727413 INFO (jetty-launcher-937-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 727413 INFO (jetty-launcher-937-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 727413 INFO (jetty-launcher-937-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-09-28T21:28:13.863Z
[junit4] 2> 727417 INFO (jetty-launcher-937-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 727420 INFO (jetty-launcher-937-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33022/solr
[junit4] 2> 727430 INFO (jetty-launcher-937-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33022/solr
[junit4] 2> 727596 INFO (jetty-launcher-937-thread-1)
[n:127.0.0.1:48897_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 727597 INFO (jetty-launcher-937-thread-1)
[n:127.0.0.1:48897_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:48897_solr
[junit4] 2> 727598 INFO (jetty-launcher-937-thread-1)
[n:127.0.0.1:48897_solr ] o.a.s.c.Overseer Overseer
(id=98738771965247492-127.0.0.1:48897_solr-n_0000000000) starting
[junit4] 2> 727609 INFO (jetty-launcher-937-thread-1)
[n:127.0.0.1:48897_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:48897_solr
[junit4] 2> 727612 INFO
(zkCallback-949-thread-1-processing-n:127.0.0.1:38625_solr)
[n:127.0.0.1:38625_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 727613 INFO
(zkCallback-945-thread-1-processing-n:127.0.0.1:48897_solr)
[n:127.0.0.1:48897_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 727614 INFO (jetty-launcher-937-thread-2)
[n:127.0.0.1:38625_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 727616 INFO (jetty-launcher-937-thread-2)
[n:127.0.0.1:38625_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:38625_solr
[junit4] 2> 727618 INFO
(zkCallback-949-thread-1-processing-n:127.0.0.1:38625_solr)
[n:127.0.0.1:38625_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 727618 INFO
(zkCallback-945-thread-1-processing-n:127.0.0.1:48897_solr)
[n:127.0.0.1:48897_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 727653 INFO (jetty-launcher-937-thread-1)
[n:127.0.0.1:48897_solr ] o.a.s.c.CoreContainer Initializing authentication
plugin: org.apache.solr.security.HadoopAuthPlugin
[junit4] 2> 727659 INFO (jetty-launcher-937-thread-1)
[n:127.0.0.1:48897_solr ] o.a.s.s.HadoopAuthPlugin Params:
{delegation-token.token-kind=solr-dt, cookie.domain=127.0.0.1,
zk-dt-secret-manager.znodeWorkingPath=solr/security/zkdtsm,
signer.secret.provider.zookeeper.path=/token, type=simple,
zk-dt-secret-manager.enable=true, signer.secret.provider=zookeeper}
[junit4] 2> 727710 INFO (jetty-launcher-937-thread-2)
[n:127.0.0.1:38625_solr ] o.a.s.c.CoreContainer Initializing authentication
plugin: org.apache.solr.security.HadoopAuthPlugin
[junit4] 2> 727711 INFO (jetty-launcher-937-thread-2)
[n:127.0.0.1:38625_solr ] o.a.s.s.HadoopAuthPlugin Params:
{delegation-token.token-kind=solr-dt, cookie.domain=127.0.0.1,
zk-dt-secret-manager.znodeWorkingPath=solr/security/zkdtsm,
signer.secret.provider.zookeeper.path=/token, type=simple,
zk-dt-secret-manager.enable=true, signer.secret.provider=zookeeper}
[junit4] 2> 727723 INFO (jetty-launcher-937-thread-2)
[n:127.0.0.1:38625_solr ] o.a.c.f.i.CuratorFrameworkImpl Starting
[junit4] 2> 727723 INFO (jetty-launcher-937-thread-1)
[n:127.0.0.1:48897_solr ] o.a.c.f.i.CuratorFrameworkImpl Starting
[junit4] 2> 727749 INFO (jetty-launcher-937-thread-2-EventThread)
[n:127.0.0.1:38625_solr ] o.a.c.f.s.ConnectionStateManager State change:
CONNECTED
[junit4] 2> 727749 INFO (jetty-launcher-937-thread-1-EventThread)
[n:127.0.0.1:48897_solr ] o.a.c.f.s.ConnectionStateManager State change:
CONNECTED
[junit4] 2> 727870 INFO (jetty-launcher-937-thread-2)
[n:127.0.0.1:38625_solr ] o.a.s.c.CoreContainer PKIAuthenticationPlugin is
managing internode requests
[junit4] 2> 727873 INFO (jetty-launcher-937-thread-1)
[n:127.0.0.1:48897_solr ] o.a.s.c.CoreContainer PKIAuthenticationPlugin is
managing internode requests
[junit4] 2> 727943 INFO (jetty-launcher-937-thread-2)
[n:127.0.0.1:38625_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_38625.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3896339
[junit4] 2> 727943 INFO (jetty-launcher-937-thread-1)
[n:127.0.0.1:48897_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_48897.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3896339
[junit4] 2> 727955 INFO (jetty-launcher-937-thread-1)
[n:127.0.0.1:48897_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_48897.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3896339
[junit4] 2> 727955 INFO (jetty-launcher-937-thread-1)
[n:127.0.0.1:48897_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_48897.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3896339
[junit4] 2> 727956 INFO (jetty-launcher-937-thread-1)
[n:127.0.0.1:48897_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.security.hadoop.TestDelegationWithHadoopAuth_BC42AB722013EF1D-001/tempDir-001/node1/.
[junit4] 2> 727957 WARN (jetty-launcher-937-thread-2)
[n:127.0.0.1:38625_solr ] o.a.s.m.r.j.JmxMetricsReporter Unable to register
gauge
[junit4] 2> javax.management.InstanceNotFoundException:
solr_38625:dom1=solr,dom2=jvm,name0=buffers,name1=mapped,name=Count
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1095)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:427)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:415)
[junit4] 2> at
com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:546)
[junit4] 2> at
org.apache.solr.metrics.reporters.jmx.JmxMetricsReporter$JmxListener.registerMBean(JmxMetricsReporter.java:530)
[junit4] 2> at
org.apache.solr.metrics.reporters.jmx.JmxMetricsReporter$JmxListener.onGaugeAdded(JmxMetricsReporter.java:565)
[junit4] 2> at
org.apache.solr.metrics.reporters.jmx.JmxMetricsReporter.lambda$start$0(JmxMetricsReporter.java:738)
[junit4] 2> at java.util.HashMap.forEach(HashMap.java:1288)
[junit4] 2> at
org.apache.solr.metrics.reporters.jmx.JmxMetricsReporter.start(JmxMetricsReporter.java:728)
[junit4] 2> at
org.apache.solr.metrics.reporters.SolrJmxReporter.doInit(SolrJmxReporter.java:109)
[junit4] 2> at
org.apache.solr.metrics.SolrMetricReporter.init(SolrMetricReporter.java:70)
[junit4] 2> at
org.apache.solr.metrics.SolrMetricManager.loadReporter(SolrMetricManager.java:849)
[junit4] 2> at
org.apache.solr.metrics.SolrMetricManager.loadReporters(SolrMetricManager.java:817)
[junit4] 2> at
org.apache.solr.core.CoreContainer.load(CoreContainer.java:548)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.createCoreContainer(SolrDispatchFilter.java:263)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.init(SolrDispatchFilter.java:183)
[junit4] 2> at
org.eclipse.jetty.servlet.FilterHolder.initialize(FilterHolder.java:139)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.initialize(ServletHandler.java:873)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.updateMappings(ServletHandler.java:1596)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.setFilterMappings(ServletHandler.java:1659)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.addFilterMapping(ServletHandler.java:1316)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.addFilterWithMapping(ServletHandler.java:1145)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletContextHandler.addFilter(ServletContextHandler.java:448)
[junit4] 2> at
org.apache.solr.client.solrj.embedded.JettySolrRunner$1.lifeCycleStarted(JettySolrRunner.java:306)
[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:394)
[junit4] 2> at
org.apache.solr.client.solrj.embedded.JettySolrRunner.start(JettySolrRunner.java:367)
[junit4] 2> at
org.apache.solr.cloud.MiniSolrCloudCluster.startJettySolrRunner(MiniSolrCloudCluster.java:384)
[junit4] 2> at
org.apache.solr.cloud.MiniSolrCloudCluster.lambda$new$0(MiniSolrCloudCluster.java:247)
[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:188)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 727960 INFO (jetty-launcher-937-thread-2)
[n:127.0.0.1:38625_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_38625.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3896339
[junit4] 2> 727960 INFO (jetty-launcher-937-thread-2)
[n:127.0.0.1:38625_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_38625.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3896339
[junit4] 2> 727963 INFO (jetty-launcher-937-thread-2)
[n:127.0.0.1:38625_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.security.hadoop.TestDelegationWithHadoopAuth_BC42AB722013EF1D-001/tempDir-001/node2/.
[junit4] 2> 727996 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 0x15eca63d48c0009, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 728013 INFO
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenSolrClient-seed#[BC42AB722013EF1D])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenSolrClient
[junit4] 2> 728081 WARN
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenSolrClient-seed#[BC42AB722013EF1D])
[ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth=; Domain=127.0.0.1; Expires= et, 01-jan-1970 00:00:00 GMT; Secure;
HttpOnly". Invalid 'expires' attribute: et, 01-jan-1970 00:00:00 GMT
[junit4] 2> 728100 INFO (qtp1944190522-5261) [n:127.0.0.1:48897_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params
action=LIST&delegation=GgADZm9vA2ZvbwCKAV7KY9efigFe7nBbnwEEFE1gm6e2ofkZGHZLDEyEyBY6Lo8GB3NvbHItZHQA&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 728100 INFO (qtp1944190522-5261) [n:127.0.0.1:48897_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={action=LIST&delegation=GgADZm9vA2ZvbwCKAV7KY9efigFe7nBbnwEEFE1gm6e2ofkZGHZLDEyEyBY6Lo8GB3NvbHItZHQA&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 728102 INFO
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenSolrClient-seed#[BC42AB722013EF1D])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenSolrClient
[junit4] IGNOR/A 0.00s J1 |
TestDelegationWithHadoopAuth.testDelegationTokenCancelFail
[junit4] > Assumption #1: 'awaitsfix' test group is disabled
(@AwaitsFix(bugUrl=https://issues.apache.org/jira/browse/HADOOP-14044))
[junit4] 2> 728117 INFO
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenVerify-seed#[BC42AB722013EF1D])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenVerify
[junit4] 2> 728136 INFO (qtp1944190522-5264) [n:127.0.0.1:48897_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params
action=LIST&delegation=GgADZm9vA2ZvbwCKAV7KY9foigFe7nBb6AIEFHaFSlib8y5gE-FYIqrWF59Y4G3TB3NvbHItZHQA&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 728136 INFO (qtp1944190522-5264) [n:127.0.0.1:48897_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={action=LIST&delegation=GgADZm9vA2ZvbwCKAV7KY9foigFe7nBb6AIEFHaFSlib8y5gE-FYIqrWF59Y4G3TB3NvbHItZHQA&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 728149 WARN
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenVerify-seed#[BC42AB722013EF1D])
[ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth=; Domain=127.0.0.1; Expires= et, 01-jan-1970 00:00:00 GMT; Secure;
HttpOnly". Invalid 'expires' attribute: et, 01-jan-1970 00:00:00 GMT
[junit4] 2> 728157 INFO
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenVerify-seed#[BC42AB722013EF1D])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 728158 INFO
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenVerify-seed#[BC42AB722013EF1D])
[ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at
127.0.0.1:33022/solr ready
[junit4] 2> 728166 INFO (qtp1944190522-5261) [n:127.0.0.1:48897_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params
action=LIST&delegation=GgADZm9vA2ZvbwCKAV7KY9foigFe7nBb6AIEFHaFSlib8y5gE-FYIqrWF59Y4G3TB3NvbHItZHQA&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 728166 INFO (qtp1944190522-5261) [n:127.0.0.1:48897_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={action=LIST&delegation=GgADZm9vA2ZvbwCKAV7KY9foigFe7nBb6AIEFHaFSlib8y5gE-FYIqrWF59Y4G3TB3NvbHItZHQA&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 728189 WARN
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenVerify-seed#[BC42AB722013EF1D])
[ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth=; Domain=127.0.0.1; Expires= et, 01-jan-1970 00:00:00 GMT; Secure;
HttpOnly". Invalid 'expires' attribute: et, 01-jan-1970 00:00:00 GMT
[junit4] 2> 728190 INFO
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenVerify-seed#[BC42AB722013EF1D])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenVerify
[junit4] 2> 728216 INFO
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenRenewFail-seed#[BC42AB722013EF1D])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenRenewFail
[junit4] 2> 728225 WARN (qtp1944190522-5264) [n:127.0.0.1:48897_solr ]
o.a.h.s.a.s.AuthenticationFilter Authentication exception:
org.apache.hadoop.security.AccessControlException: bar tries to renew a token
with renewer foo
[junit4] 2> 728225 WARN (qtp1944190522-5264) [n:127.0.0.1:48897_solr ]
o.a.s.s.HadoopAuthPlugin Could not find
org.apache.solr.security.authentication.requestcontinues
[junit4] 2> 728226 WARN
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenRenewFail-seed#[BC42AB722013EF1D])
[ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth=; Domain=127.0.0.1; Expires= et, 01-jan-1970 00:00:00 GMT; Secure;
HttpOnly". Invalid 'expires' attribute: et, 01-jan-1970 00:00:00 GMT
[junit4] 2> 728236 WARN (qtp553973056-5280) [ ]
o.a.h.s.a.s.AuthenticationFilter Authentication exception:
org.apache.hadoop.security.AccessControlException: bar tries to renew a token
with renewer foo
[junit4] 2> 728237 WARN (qtp553973056-5280) [ ]
o.a.s.s.HadoopAuthPlugin Could not find
org.apache.solr.security.authentication.requestcontinues
[junit4] 2> 728238 WARN
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenRenewFail-seed#[BC42AB722013EF1D])
[ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth=; Domain=127.0.0.1; Expires= et, 01-jan-1970 00:00:00 GMT; Secure;
HttpOnly". Invalid 'expires' attribute: et, 01-jan-1970 00:00:00 GMT
[junit4] 2> 728244 WARN (qtp1944190522-5267) [ ]
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> 728245 WARN (qtp1944190522-5267) [ ]
o.a.s.s.HadoopAuthPlugin Could not find
org.apache.solr.security.authentication.requestcontinues
[junit4] 2> 728245 WARN
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenRenewFail-seed#[BC42AB722013EF1D])
[ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth=; Domain=127.0.0.1; Expires= et, 01-jan-1970 00:00:00 GMT; Secure;
HttpOnly". Invalid 'expires' attribute: et, 01-jan-1970 00:00:00 GMT
[junit4] 2> 728247 WARN (qtp553973056-5278) [ ]
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> 728248 WARN (qtp553973056-5278) [ ]
o.a.s.s.HadoopAuthPlugin Could not find
org.apache.solr.security.authentication.requestcontinues
[junit4] 2> 728248 WARN
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenRenewFail-seed#[BC42AB722013EF1D])
[ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth=; Domain=127.0.0.1; Expires= et, 01-jan-1970 00:00:00 GMT; Secure;
HttpOnly". Invalid 'expires' attribute: et, 01-jan-1970 00:00:00 GMT
[junit4] 2> 728249 INFO
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenRenewFail-seed#[BC42AB722013EF1D])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenRenewFail
[junit4] 2> 728266 INFO
(TEST-TestDelegationWithHadoopAuth.testZNodePaths-seed#[BC42AB722013EF1D]) [
] o.a.s.SolrTestCaseJ4 ###Starting testZNodePaths
[junit4] 2> 728274 INFO
(TEST-TestDelegationWithHadoopAuth.testZNodePaths-seed#[BC42AB722013EF1D]) [
] o.a.s.SolrTestCaseJ4 ###Ending testZNodePaths
[junit4] 2> 728295 INFO
(TEST-TestDelegationWithHadoopAuth.testDelegationOtherOp-seed#[BC42AB722013EF1D])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationOtherOp
[junit4] 2> 728306 INFO (qtp1944190522-5263) [n:127.0.0.1:48897_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params
op=someSolrOperation&action=LIST&user.name=foo&wt=javabin&version=2 and
sendToOCPQueue=true
[junit4] 2> 728306 INFO (qtp1944190522-5263) [n:127.0.0.1:48897_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={op=someSolrOperation&action=LIST&user.name=foo&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 728311 WARN
(TEST-TestDelegationWithHadoopAuth.testDelegationOtherOp-seed#[BC42AB722013EF1D])
[ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth="u=foo&p=foo&t=simple-dt&e=1506670094756&s=oy4O+l3YohAfYpVojsLk3Mafluo=";
Domain=127.0.0.1; Expires=pet, 29-sep-2017 07:28:14 GMT; Secure; HttpOnly".
Invalid 'expires' attribute: pet, 29-sep-2017 07:28:14 GMT
[junit4] 2> 728312 INFO
(TEST-TestDelegationWithHadoopAuth.testDelegationOtherOp-seed#[BC42AB722013EF1D])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationOtherOp
[junit4] 2> 728345 INFO
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenRenew-seed#[BC42AB722013EF1D])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenRenew
[junit4] 2> 728350 WARN (qtp1944190522-5261) [n:127.0.0.1:48897_solr ]
o.a.h.s.a.s.AuthenticationFilter Authentication exception:
org.apache.hadoop.security.AccessControlException: foo is trying to renew a
token with wrong password
[junit4] 2> 728350 WARN (qtp1944190522-5261) [n:127.0.0.1:48897_solr ]
o.a.s.s.HadoopAuthPlugin Could not find
org.apache.solr.security.authentication.requestcontinues
[junit4] 2> 728351 WARN
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenRenew-seed#[BC42AB722013EF1D])
[ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth=; Domain=127.0.0.1; Expires= et, 01-jan-1970 00:00:00 GMT; Secure;
HttpOnly". Invalid 'expires' attribute: et, 01-jan-1970 00:00:00 GMT
[junit4] 2> 728351 INFO
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenRenew-seed#[BC42AB722013EF1D])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenRenew
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=TestDelegationWithHadoopAuth -Dtests.method=testDelegationTokenRenew
-Dtests.seed=BC42AB722013EF1D -Dtests.slow=true -Dtests.locale=sr-Latn-ME
-Dtests.timezone=America/Nipigon -Dtests.asserts=true
-Dtests.file.encoding=ISO-8859-1
[junit4] FAILURE 0.04s J1 |
TestDelegationWithHadoopAuth.testDelegationTokenRenew <<<
[junit4] > Throwable #1: java.lang.AssertionError: expected:<200> but
was:<403>
[junit4] > at
__randomizedtesting.SeedInfo.seed([BC42AB722013EF1D:8BD95F6C18DF32B9]:0)
[junit4] > at
org.apache.solr.security.hadoop.TestDelegationWithHadoopAuth.renewDelegationToken(TestDelegationWithHadoopAuth.java:118)
[junit4] > at
org.apache.solr.security.hadoop.TestDelegationWithHadoopAuth.verifyDelegationTokenRenew(TestDelegationWithHadoopAuth.java:302)
[junit4] > at
org.apache.solr.security.hadoop.TestDelegationWithHadoopAuth.testDelegationTokenRenew(TestDelegationWithHadoopAuth.java:319)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 728373 INFO
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenCancel-seed#[BC42AB722013EF1D])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenCancel
[junit4] 2> 728403 INFO
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenCancel-seed#[BC42AB722013EF1D])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 728404 INFO
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenCancel-seed#[BC42AB722013EF1D])
[ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at
127.0.0.1:33022/solr ready
[junit4] 2> 728412 ERROR (qtp1944190522-5264) [n:127.0.0.1:48897_solr ]
o.a.h.s.t.d.ZKDelegationTokenSecretManager No node in path
[/ZKDTSMTokensRoot/DT_7]
[junit4] 2> 728422 INFO
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenCancel-seed#[BC42AB722013EF1D])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 728423 INFO
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenCancel-seed#[BC42AB722013EF1D])
[ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at
127.0.0.1:33022/solr ready
[junit4] 2> 728430 WARN
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenCancel-seed#[BC42AB722013EF1D])
[ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth=; Domain=127.0.0.1; Expires= et, 01-jan-1970 00:00:00 GMT; Secure;
HttpOnly". Invalid 'expires' attribute: et, 01-jan-1970 00:00:00 GMT
[junit4] 2> 728458 WARN
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenCancel-seed#[BC42AB722013EF1D])
[ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth=; Domain=127.0.0.1; Expires= et, 01-jan-1970 00:00:00 GMT; Secure;
HttpOnly". Invalid 'expires' attribute: et, 01-jan-1970 00:00:00 GMT
[junit4] 2> 728477 INFO
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenCancel-seed#[BC42AB722013EF1D])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 728478 INFO
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenCancel-seed#[BC42AB722013EF1D])
[ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at
127.0.0.1:33022/solr ready
[junit4] 2> 728486 ERROR (qtp1944190522-5261) [n:127.0.0.1:48897_solr ]
o.a.h.s.t.d.ZKDelegationTokenSecretManager No node in path
[/ZKDTSMTokensRoot/DT_8]
[junit4] 2> 728526 WARN
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenCancel-seed#[BC42AB722013EF1D])
[ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth=; Domain=127.0.0.1; Expires= et, 01-jan-1970 00:00:00 GMT; Secure;
HttpOnly". Invalid 'expires' attribute: et, 01-jan-1970 00:00:00 GMT
[junit4] 2> 728531 INFO
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenCancel-seed#[BC42AB722013EF1D])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 728532 INFO
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenCancel-seed#[BC42AB722013EF1D])
[ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at
127.0.0.1:33022/solr ready
[junit4] 2> 728545 WARN
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenCancel-seed#[BC42AB722013EF1D])
[ ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie:
hadoop.auth=; Domain=127.0.0.1; Expires= et, 01-jan-1970 00:00:00 GMT; Secure;
HttpOnly". Invalid 'expires' attribute: et, 01-jan-1970 00:00:00 GMT
[junit4] 2> 728547 INFO
(TEST-TestDelegationWithHadoopAuth.testDelegationTokenCancel-seed#[BC42AB722013EF1D])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenCancel
[junit4] 2> 728549 INFO (jetty-closer-938-thread-1) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@9a32663{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 728549 INFO (jetty-closer-938-thread-2) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@4fa4db54{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 728550 INFO (jetty-closer-938-thread-1) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=952336400
[junit4] 2> 728550 INFO (jetty-closer-938-thread-2) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1455665080
[junit4] 2> 728551 INFO (jetty-closer-938-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 728551 INFO (jetty-closer-938-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 728551 INFO (jetty-closer-938-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1aaa6bf: rootName =
solr_48897, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@306d9f0d
[junit4] 2> 728551 INFO (jetty-closer-938-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@276c47ca: rootName =
solr_38625, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@7c64891a
[junit4] 2> 728575 INFO (jetty-closer-938-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 728575 INFO (jetty-closer-938-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@7262516f: rootName =
solr_38625, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@3987ae98
[junit4] 2> 728575 INFO (jetty-closer-938-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 728575 INFO (jetty-closer-938-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@24ab5ccd: rootName =
solr_48897, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@3987ae98
[junit4] 2> 728581 INFO (jetty-closer-938-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 728581 INFO (jetty-closer-938-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@374442e9: rootName =
solr_38625, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@5e14e3bc
[junit4] 2> 728581 INFO (jetty-closer-938-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 728581 INFO (jetty-closer-938-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@7c94ff87: rootName =
solr_48897, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@5e14e3bc
[junit4] 2> 728583 INFO (jetty-closer-938-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 728584 INFO (jetty-closer-938-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 728584 INFO (jetty-closer-938-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 728585 INFO (jetty-closer-938-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=98738771965247492-127.0.0.1:48897_solr-n_0000000000) closing
[junit4] 2> 728585 INFO
(OverseerStateUpdate-98738771965247492-127.0.0.1:48897_solr-n_0000000000)
[n:127.0.0.1:48897_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:48897_solr
[junit4] 2> 728586 INFO (jetty-closer-938-thread-2) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 728590 ERROR
(Thread[Thread-1372,5,TGRP-TestDelegationWithHadoopAuth])
[n:127.0.0.1:38625_solr ] o.a.h.s.t.d.AbstractDelegationTokenSecretManager
ExpiredTokenRemover received java.lang.InterruptedException: sleep interrupted
[junit4] 2> 728590 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 0x15eca63d48c0006, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 728590 INFO
(zkCallback-945-thread-1-processing-n:127.0.0.1:48897_solr)
[n:127.0.0.1:48897_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (1)
[junit4] 2> 728593 WARN
(zkCallback-945-thread-1-processing-n:127.0.0.1:48897_solr)
[n:127.0.0.1:48897_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 728594 ERROR
(Thread[Thread-1374,5,TGRP-TestDelegationWithHadoopAuth])
[n:127.0.0.1:48897_solr ] o.a.h.s.t.d.AbstractDelegationTokenSecretManager
ExpiredTokenRemover received java.lang.InterruptedException: sleep interrupted
[junit4] 2> 728603 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 0x15eca63d48c0008, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 728603 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 0x15eca63d48c0007, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 728608 INFO (jetty-closer-938-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@36871ca{/solr,null,UNAVAILABLE}
[junit4] 2> 728608 INFO (jetty-closer-938-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@29a5da93{/solr,null,UNAVAILABLE}
[junit4] 2> 728612 ERROR
(SUITE-TestDelegationWithHadoopAuth-seed#[BC42AB722013EF1D]-worker) [ ]
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper
server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 728613 INFO
(SUITE-TestDelegationWithHadoopAuth-seed#[BC42AB722013EF1D]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:33022 33022
[junit4] 2> 728655 INFO (Thread-1355) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:33022 33022
[junit4] 2> 728657 WARN (Thread-1355) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 7 /solr/aliases.json
[junit4] 2> 2 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 7 /solr/clusterprops.json
[junit4] 2> 7 /solr/clusterstate.json
[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/ZKDTSMMasterKeyRoot/DK_1
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_1
[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/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_5
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot/DK_4
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_4
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMSeqNumRoot
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 7 /solr/live_nodes
[junit4] 2> 7 /solr/collections
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.security.hadoop.TestDelegationWithHadoopAuth_BC42AB722013EF1D-001
[junit4] 2> Sep 28, 2017 9:28:15 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 5 leaked
thread(s).
[junit4] 2> NOTE: test params are:
codec=HighCompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=HIGH_COMPRESSION,
chunkSize=1, maxDocsPerChunk=2, blockSize=8),
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=HIGH_COMPRESSION,
chunkSize=1, blockSize=8)), sim=RandomSimilarity(queryNorm=true): {},
locale=sr-Latn-ME, timezone=America/Nipigon
[junit4] 2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_141
(64-bit)/cpus=3,threads=1,free=317152792,total=534773760
[junit4] 2> NOTE: All tests run in this JVM:
[DistributedFacetPivotSmallAdvancedTest, MoveReplicaHDFSUlogDirTest,
TestUnifiedSolrHighlighter, ZkSolrClientTest, UtilsToolTest,
DistribDocExpirationUpdateProcessorTest, TestSolrCLIRunExample,
OverseerCollectionConfigSetProcessorTest, TestReloadAndDeleteDocs,
TestRestoreCore, SolrCoreCheckLockOnStartupTest, TestReloadDeadlock,
TestDocTermOrds, TestConfigSetsAPI, TestCoreDiscovery, SolrXmlInZkTest,
TestStressLucene, SolrSlf4jReporterTest, PreAnalyzedFieldTest,
TestHdfsCloudBackupRestore, TestCloudSearcherWarming,
CollectionsAPIAsyncDistributedZkTest, TestFieldSortValues, TestSolrXml,
TestXmlQParser, UpdateRequestProcessorFactoryTest, TestDFISimilarityFactory,
HdfsRestartWhileUpdatingTest, TestFastOutputStream, TestBM25SimilarityFactory,
TestFieldCacheWithThreads, ZkStateReaderTest, TestSimpleTrackingShardHandler,
TestSolrConfigHandlerConcurrent, SystemInfoHandlerTest,
TestConfigSetsAPIZkFailure, LukeRequestHandlerTest, TestExpandComponent,
TestCSVLoader, TolerantUpdateProcessorTest, TestEmbeddedSolrServerSchemaAPI,
DataDrivenBlockJoinTest, TestRecovery, TestConfig, TestCollationField,
DebugComponentTest, BaseCdcrDistributedZkTest, TestStressUserVersions,
JsonLoaderTest, BitVectorTest, TestChildDocTransformer,
TestSortByMinMaxFunction, SolrCmdDistributorTest, TestReplicationHandlerBackup,
TestLuceneMatchVersion, SpatialRPTFieldTypeTest, TestSQLHandlerNonCloud,
TestRequestStatusCollectionAPI, TestComponentsName,
TestDelegationWithHadoopAuth]
[junit4] Completed [106/733 (1!)] on J1 in 2.43s, 8 tests, 1 failure, 1
skipped <<< FAILURES!
[...truncated 48797 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
