lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@thetaphi.de>
Subject [JENKINS] Lucene-Solr-master-MacOSX (64bit/jdk1.8.0) - Build # 3596 - Still Unstable!
Date Mon, 10 Oct 2016 08:32:28 GMT
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-MacOSX/3596/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC

1 tests failed.
FAILED:  org.apache.solr.cloud.TestSolrCloudWithKerberosAlt.testBasics

Error Message:
Could not find collection:testkerberoscollection

Stack Trace:
java.lang.AssertionError: Could not find collection:testkerberoscollection
	at __randomizedtesting.SeedInfo.seed([4E6CEC3CD492BFE4:73B44210EC7CE194]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.junit.Assert.assertNotNull(Assert.java:526)
	at org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:153)
	at org.apache.solr.cloud.TestSolrCloudWithKerberosAlt.testCollectionCreateSearchDelete(TestSolrCloudWithKerberosAlt.java:206)
	at org.apache.solr.cloud.TestSolrCloudWithKerberosAlt.testBasics(TestSolrCloudWithKerberosAlt.java:152)
	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 11302 lines...]
   [junit4] Suite: org.apache.solr.cloud.TestSolrCloudWithKerberosAlt
   [junit4]   2> 1199377 WARN  (TEST-TestSolrCloudWithKerberosAlt.testBasics-seed#[4E6CEC3CD492BFE4])
[    ] o.a.d.s.c.DefaultDirectoryService You didn't change the admin password of directory
service instance 'DefaultKrbServer'.  Please update the admin password as soon as possible
to prevent a possible security breach.
   [junit4]   2> 1201634 INFO  (TEST-TestSolrCloudWithKerberosAlt.testBasics-seed#[4E6CEC3CD492BFE4])
[    ] o.a.s.c.TestSolrCloudWithKerberosAlt Enable delegation token: true
   [junit4]   2> 1201635 INFO  (TEST-TestSolrCloudWithKerberosAlt.testBasics-seed#[4E6CEC3CD492BFE4])
[    ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.TestSolrCloudWithKerberosAlt_4E6CEC3CD492BFE4-001/tempDir-002
   [junit4]   2> 1201635 INFO  (TEST-TestSolrCloudWithKerberosAlt.testBasics-seed#[4E6CEC3CD492BFE4])
[    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1201636 INFO  (Thread-1601) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1201636 INFO  (Thread-1601) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 1201740 INFO  (TEST-TestSolrCloudWithKerberosAlt.testBasics-seed#[4E6CEC3CD492BFE4])
[    ] o.a.s.c.ZkTestServer start zk server on port:52023
   [junit4]   2> 1201741 WARN  (TEST-TestSolrCloudWithKerberosAlt.testBasics-seed#[4E6CEC3CD492BFE4]-SendThread(127.0.0.1:52023))
[    ] o.a.z.ClientCnxn SASL configuration failed: javax.security.auth.login.LoginException:
No JAAS configuration section named 'Client' was found in specified JAAS configuration file:
'/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.TestSolrCloudWithKerberosAlt_4E6CEC3CD492BFE4-001/tempDir-001/minikdc/jaas-client.conf'.
Will continue connection to Zookeeper server without SASL authentication, if Zookeeper server
allows it.
   [junit4]   2> 1201742 WARN  (zkCallback-1340-thread-1) [    ] o.a.s.c.c.ConnectionManager
Watcher org.apache.solr.common.cloud.ConnectionManager@ec21ae name: ZooKeeperConnection Watcher:127.0.0.1:52023
got event WatchedEvent state:AuthFailed type:None path:null path: null type: None
   [junit4]   2> 1201742 WARN  (zkCallback-1340-thread-1) [    ] o.a.s.c.c.ConnectionManager
zkClient received AuthFailed
   [junit4]   2> 1201871 INFO  (jetty-launcher-1339-thread-1) [    ] o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 1201872 INFO  (jetty-launcher-1339-thread-1) [    ] o.e.j.s.h.ContextHandler
Started o.e.j.s.ServletContextHandler@3c9af2cf{/solr,null,AVAILABLE}
   [junit4]   2> 1201873 INFO  (jetty-launcher-1339-thread-1) [    ] o.e.j.s.ServerConnector
Started ServerConnector@2f757efd{HTTP/1.1,[http/1.1]}{127.0.0.1:52025}
   [junit4]   2> 1201873 INFO  (jetty-launcher-1339-thread-1) [    ] o.e.j.s.Server Started
@1209950ms
   [junit4]   2> 1201873 INFO  (jetty-launcher-1339-thread-1) [    ] o.a.s.c.s.e.JettySolrRunner
Jetty properties: {hostContext=/solr, hostPort=52025}
   [junit4]   2> 1201874 INFO  (jetty-launcher-1339-thread-1) [    ] o.a.s.s.SolrDispatchFilter
 ___      _       Welcome to Apache Solr? version 7.0.0
   [junit4]   2> 1201874 INFO  (jetty-launcher-1339-thread-1) [    ] o.a.s.s.SolrDispatchFilter
/ __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1201874 INFO  (jetty-launcher-1339-thread-1) [    ] o.a.s.s.SolrDispatchFilter
\__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1201874 INFO  (jetty-launcher-1339-thread-1) [    ] o.a.s.s.SolrDispatchFilter
|___/\___/_|_|    Start time: 2016-10-10T07:21:09.907Z
   [junit4]   2> 1201875 WARN  (jetty-launcher-1339-thread-1-SendThread(127.0.0.1:52023))
[    ] o.a.z.ClientCnxn SASL configuration failed: javax.security.auth.login.LoginException:
No JAAS configuration section named 'Client' was found in specified JAAS configuration file:
'/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.TestSolrCloudWithKerberosAlt_4E6CEC3CD492BFE4-001/tempDir-001/minikdc/jaas-client.conf'.
Will continue connection to Zookeeper server without SASL authentication, if Zookeeper server
allows it.
   [junit4]   2> 1201876 WARN  (zkCallback-1341-thread-1) [    ] o.a.s.c.c.ConnectionManager
Watcher org.apache.solr.common.cloud.ConnectionManager@69053c5a name: ZooKeeperConnection
Watcher:127.0.0.1:52023/solr got event WatchedEvent state:AuthFailed type:None path:null path:
null type: None
   [junit4]   2> 1201876 WARN  (zkCallback-1341-thread-1) [    ] o.a.s.c.c.ConnectionManager
zkClient received AuthFailed
   [junit4]   2> 1201892 INFO  (jetty-launcher-1339-thread-1) [    ] o.a.s.s.SolrDispatchFilter
solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1201909 INFO  (jetty-launcher-1339-thread-1) [    ] o.a.s.c.ZkContainer
Zookeeper client=127.0.0.1:52023/solr
   [junit4]   2> 1201910 WARN  (jetty-launcher-1339-thread-1-SendThread(127.0.0.1:52023))
[    ] o.a.z.ClientCnxn SASL configuration failed: javax.security.auth.login.LoginException:
No JAAS configuration section named 'Client' was found in specified JAAS configuration file:
'/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.TestSolrCloudWithKerberosAlt_4E6CEC3CD492BFE4-001/tempDir-001/minikdc/jaas-client.conf'.
Will continue connection to Zookeeper server without SASL authentication, if Zookeeper server
allows it.
   [junit4]   2> 1201911 WARN  (zkCallback-1344-thread-1) [    ] o.a.s.c.c.ConnectionManager
Watcher org.apache.solr.common.cloud.ConnectionManager@492efb68 name: ZooKeeperConnection
Watcher:127.0.0.1:52023 got event WatchedEvent state:AuthFailed type:None path:null path:
null type: None
   [junit4]   2> 1201912 WARN  (zkCallback-1344-thread-1) [    ] o.a.s.c.c.ConnectionManager
zkClient received AuthFailed
   [junit4]   2> 1201947 WARN  (jetty-launcher-1339-thread-1-SendThread(127.0.0.1:52023))
[n:127.0.0.1:52025_solr    ] o.a.z.ClientCnxn SASL configuration failed: javax.security.auth.login.LoginException:
No JAAS configuration section named 'Client' was found in specified JAAS configuration file:
'/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.TestSolrCloudWithKerberosAlt_4E6CEC3CD492BFE4-001/tempDir-001/minikdc/jaas-client.conf'.
Will continue connection to Zookeeper server without SASL authentication, if Zookeeper server
allows it.
   [junit4]   2> 1201948 WARN  (zkCallback-1345-thread-1-processing-n:127.0.0.1:52025_solr)
[n:127.0.0.1:52025_solr    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7672ee7d
name: ZooKeeperConnection Watcher:127.0.0.1:52023/solr got event WatchedEvent state:AuthFailed
type:None path:null path: null type: None
   [junit4]   2> 1201948 WARN  (zkCallback-1345-thread-1-processing-n:127.0.0.1:52025_solr)
[n:127.0.0.1:52025_solr    ] o.a.s.c.c.ConnectionManager zkClient received AuthFailed
   [junit4]   2> 1202227 INFO  (jetty-launcher-1339-thread-1) [n:127.0.0.1:52025_solr 
  ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:52025_solr
   [junit4]   2> 1202240 INFO  (jetty-launcher-1339-thread-1) [n:127.0.0.1:52025_solr 
  ] o.a.s.c.Overseer Overseer (id=96736645590089731-127.0.0.1:52025_solr-n_0000000000) starting
   [junit4]   2> 1202374 INFO  (jetty-launcher-1339-thread-1) [n:127.0.0.1:52025_solr 
  ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:52025_solr
   [junit4]   2> 1202387 INFO  (zkCallback-1345-thread-1-processing-n:127.0.0.1:52025_solr)
[n:127.0.0.1:52025_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper...
(0) -> (1)
   [junit4]   2> 1202393 INFO  (jetty-launcher-1339-thread-1) [n:127.0.0.1:52025_solr 
  ] o.a.s.c.CoreContainer Authentication plugin class obtained from system property 'authenticationPlugin':
org.apache.solr.security.KerberosPlugin
   [junit4]   2> 1202410 INFO  (jetty-launcher-1339-thread-1) [n:127.0.0.1:52025_solr 
  ] o.a.s.c.s.i.Krb5HttpClientBuilder Setting up SPNego auth with config: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.TestSolrCloudWithKerberosAlt_4E6CEC3CD492BFE4-001/tempDir-001/minikdc/jaas-client.conf
   [junit4]   2> 1202473 INFO  (jetty-launcher-1339-thread-1) [n:127.0.0.1:52025_solr 
  ] o.a.s.s.KerberosPlugin Params: {token.valid=30, kerberos.principal=HTTP/127.0.0.1, kerberos.keytab=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.TestSolrCloudWithKerberosAlt_4E6CEC3CD492BFE4-001/tempDir-001/minikdc/keytabs,
cookie.domain=127.0.0.1, token.validity=36000, type=kerberos, delegation-token.token-kind=solr-dt,
cookie.path=/, zk-dt-secret-manager.znodeWorkingPath=solr/security/zkdtsm, signer.secret.provider.zookeeper.path=/token,
zk-dt-secret-manager.enable=true, kerberos.name.rules=RULE:[1:$1@$0](.*EXAMPLE.COM)s/@.*//
   [junit4]   2> RULE:[2:$2@$0](.*EXAMPLE.COM)s/@.*//
   [junit4]   2> DEFAULT, signer.secret.provider=zookeeper}
   [junit4]   2> 1202790 INFO  (jetty-launcher-1339-thread-1) [n:127.0.0.1:52025_solr 
  ] o.a.c.f.i.CuratorFrameworkImpl Starting
   [junit4]   2> 1202807 WARN  (jetty-launcher-1339-thread-1-SendThread(127.0.0.1:52023))
[n:127.0.0.1:52025_solr    ] o.a.z.ClientCnxn SASL configuration failed: javax.security.auth.login.LoginException:
No JAAS configuration section named 'Client' was found in specified JAAS configuration file:
'/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.TestSolrCloudWithKerberosAlt_4E6CEC3CD492BFE4-001/tempDir-001/minikdc/jaas-client.conf'.
Will continue connection to Zookeeper server without SASL authentication, if Zookeeper server
allows it.
   [junit4]   2> 1202828 ERROR (jetty-launcher-1339-thread-1-EventThread) [n:127.0.0.1:52025_solr
   ] o.a.c.ConnectionState Authentication failed
   [junit4]   2> 1202866 INFO  (jetty-launcher-1339-thread-1-EventThread) [n:127.0.0.1:52025_solr
   ] o.a.c.f.s.ConnectionStateManager State change: CONNECTED
   [junit4]   2> 1203656 INFO  (jetty-launcher-1339-thread-1) [n:127.0.0.1:52025_solr 
  ] o.a.s.c.s.i.Krb5HttpClientBuilder Setting up SPNego auth with config: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.TestSolrCloudWithKerberosAlt_4E6CEC3CD492BFE4-001/tempDir-001/minikdc/jaas-client.conf
   [junit4]   2> 1203660 INFO  (jetty-launcher-1339-thread-1) [n:127.0.0.1:52025_solr 
  ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.TestSolrCloudWithKerberosAlt_4E6CEC3CD492BFE4-001/tempDir-002/node1/.
   [junit4]   2> 1203663 WARN  (TEST-TestSolrCloudWithKerberosAlt.testBasics-seed#[4E6CEC3CD492BFE4]-SendThread(127.0.0.1:52023))
[    ] o.a.z.ClientCnxn SASL configuration failed: javax.security.auth.login.LoginException:
No JAAS configuration section named 'Client' was found in specified JAAS configuration file:
'/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.TestSolrCloudWithKerberosAlt_4E6CEC3CD492BFE4-001/tempDir-001/minikdc/jaas-client.conf'.
Will continue connection to Zookeeper server without SASL authentication, if Zookeeper server
allows it.
   [junit4]   2> 1203669 WARN  (zkCallback-1347-thread-1) [    ] o.a.s.c.c.ConnectionManager
Watcher org.apache.solr.common.cloud.ConnectionManager@476c683 name: ZooKeeperConnection Watcher:127.0.0.1:52023
got event WatchedEvent state:AuthFailed type:None path:null path: null type: None
   [junit4]   2> 1203669 WARN  (zkCallback-1347-thread-1) [    ] o.a.s.c.c.ConnectionManager
zkClient received AuthFailed
   [junit4]   2> 1203721 WARN  (TEST-TestSolrCloudWithKerberosAlt.testBasics-seed#[4E6CEC3CD492BFE4]-SendThread(127.0.0.1:52023))
[    ] o.a.z.ClientCnxn SASL configuration failed: javax.security.auth.login.LoginException:
No JAAS configuration section named 'Client' was found in specified JAAS configuration file:
'/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.TestSolrCloudWithKerberosAlt_4E6CEC3CD492BFE4-001/tempDir-001/minikdc/jaas-client.conf'.
Will continue connection to Zookeeper server without SASL authentication, if Zookeeper server
allows it.
   [junit4]   2> 1203722 WARN  (zkCallback-1349-thread-1) [    ] o.a.s.c.c.ConnectionManager
Watcher org.apache.solr.common.cloud.ConnectionManager@22681db0 name: ZooKeeperConnection
Watcher:127.0.0.1:52023/solr got event WatchedEvent state:AuthFailed type:None path:null path:
null type: None
   [junit4]   2> 1203722 WARN  (zkCallback-1349-thread-1) [    ] o.a.s.c.c.ConnectionManager
zkClient received AuthFailed
   [junit4]   2> 1209236 WARN  (TEST-TestSolrCloudWithKerberosAlt.testBasics-seed#[4E6CEC3CD492BFE4]-SendThread(127.0.0.1:52023))
[    ] o.a.z.ClientCnxn SASL configuration failed: javax.security.auth.login.LoginException:
No JAAS configuration section named 'Client' was found in specified JAAS configuration file:
'/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.TestSolrCloudWithKerberosAlt_4E6CEC3CD492BFE4-001/tempDir-001/minikdc/jaas-client.conf'.
Will continue connection to Zookeeper server without SASL authentication, if Zookeeper server
allows it.
   [junit4]   2> 1209237 WARN  (zkCallback-1351-thread-1) [    ] o.a.s.c.c.ConnectionManager
Watcher org.apache.solr.common.cloud.ConnectionManager@b2c2637 name: ZooKeeperConnection Watcher:127.0.0.1:52023/solr
got event WatchedEvent state:AuthFailed type:None path:null path: null type: None
   [junit4]   2> 1209237 WARN  (zkCallback-1351-thread-1) [    ] o.a.s.c.c.ConnectionManager
zkClient received AuthFailed
   [junit4]   2> 1209248 INFO  (TEST-TestSolrCloudWithKerberosAlt.testBasics-seed#[4E6CEC3CD492BFE4])
[    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1209311 WARN  (qtp996885049-7337) [    ] o.a.h.s.a.s.KerberosAuthenticationHandler
'Authorization' does not start with 'Negotiate' :  Basic aGFycnk6SGFycnlJc1ViZXJDb29s
   [junit4]   1> Debug is  true storeKey true useTicketCache false useKeyTab true doNotPrompt
false ticketCache is null isInitiator true KeyTab is /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.TestSolrCloudWithKerberosAlt_4E6CEC3CD492BFE4-001/tempDir-001/minikdc/keytabs
refreshKrb5Config is true principal is solr tryFirstPass is false useFirstPass is false storePass
is false clearPass is false
   [junit4]   1> Refreshing Kerberos configuration
   [junit4]   1> principal is solr@EXAMPLE.COM
   [junit4]   1> Will use keytab
   [junit4]   1> Commit Succeeded 
   [junit4]   1> 
   [junit4]   2> 1211256 INFO  (qtp996885049-7338) [n:127.0.0.1:52025_solr    ] o.a.s.h.a.CollectionsHandler
Invoked Collection Action :create with params replicationFactor=1&property.solr.tests.ramBufferSizeMB=100&property.solr.tests.mergePolicyFactory=org.apache.solr.index.TieredMergePolicyFactory&property.solr.tests.useMergePolicyFactory=true&property.solr.tests.useMergePolicy=false&version=2&property.solr.tests.mergeScheduler=org.apache.lucene.index.ConcurrentMergeScheduler&property.config=solrconfig-tlog.xml&property.solr.tests.maxBufferedDocs=100000&name=testkerberoscollection&action=CREATE&numShards=1&property.solr.directoryFactory=solr.RAMDirectoryFactory&wt=javabin
and sendToOCPQueue=true
   [junit4]   2> 1211270 INFO  (OverseerThreadFactory-3456-thread-1-processing-n:127.0.0.1:52025_solr)
[n:127.0.0.1:52025_solr    ] o.a.s.c.CreateCollectionCmd Create collection testkerberoscollection
   [junit4]   2> 1211270 INFO  (OverseerThreadFactory-3456-thread-1-processing-n:127.0.0.1:52025_solr)
[n:127.0.0.1:52025_solr    ] o.a.s.c.CreateCollectionCmd Only one config set found in zk -
using it:solrCloudCollectionConfig
   [junit4]   2> 1211399 WARN  (qtp996885049-7340) [    ] o.a.h.s.a.s.KerberosAuthenticationHandler
'Authorization' does not start with 'Negotiate' :  Basic aGFycnk6SGFycnlJc1ViZXJDb29s
   [junit4]   2> 1211400 ERROR (OverseerThreadFactory-3456-thread-1-processing-n:127.0.0.1:52025_solr)
[n:127.0.0.1:52025_solr    ] o.a.s.c.OverseerCollectionMessageHandler Error from shard: http://127.0.0.1:52025/solr
   [junit4]   2> org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException:
Error from server at http://127.0.0.1:52025/solr: Expected mime type application/octet-stream
but got text/html. <html>
   [junit4]   2> <head>
   [junit4]   2> <meta http-equiv="Content-Type" content="text/html;charset=ISO-8859-1"/>
   [junit4]   2> <title>Error 401 </title>
   [junit4]   2> </head>
   [junit4]   2> <body>
   [junit4]   2> <h2>HTTP ERROR: 401</h2>
   [junit4]   2> <p>Problem accessing /solr/admin/cores. Reason:
   [junit4]   2> <pre>    Authentication required</pre></p>
   [junit4]   2> <hr /><a href="http://eclipse.org/jetty">Powered by Jetty://
9.3.8.v20160314</a><hr/>
   [junit4]   2> </body>
   [junit4]   2> </html>
   [junit4]   2> 
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:578)
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:262)
   [junit4]   2> 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:251)
   [junit4]   2> 	at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
   [junit4]   2> 	at org.apache.solr.handler.component.HttpShardHandler.lambda$submit$0(HttpShardHandler.java:195)
   [junit4]   2> 	at java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]   2> 	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
   [junit4]   2> 	at java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]   2> 	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 1211401 ERROR (OverseerThreadFactory-3456-thread-1-processing-n:127.0.0.1:52025_solr)
[n:127.0.0.1:52025_solr    ] o.a.s.c.OverseerCollectionMessageHandler Cleaning up collection
[testkerberoscollection].
   [junit4]   2> 1211401 INFO  (OverseerThreadFactory-3456-thread-1-processing-n:127.0.0.1:52025_solr)
[n:127.0.0.1:52025_solr    ] o.a.s.c.OverseerCollectionMessageHandler Executing Collection
Cmd : action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true
   [junit4]   2> 1212143 INFO  (OverseerThreadFactory-3456-thread-1-processing-n:127.0.0.1:52025_solr)
[n:127.0.0.1:52025_solr    ] o.a.s.c.CreateCollectionCmd Cleaned up artifacts for failed create
collection for [testkerberoscollection]
   [junit4]   2> 1212396 INFO  (qtp996885049-7338) [n:127.0.0.1:52025_solr    ] o.a.s.h.a.CollectionsHandler
Wait for new collection to be active for at most 30 seconds. Check all shard replicas
   [junit4]   2> 1213294 INFO  (OverseerCollectionConfigSetProcessor-96736645590089731-127.0.0.1:52025_solr-n_0000000000)
[n:127.0.0.1:52025_solr    ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000000
doesn't exist.  Requestor may have disconnected from ZooKeeper
   [junit4]   2> 1242569 ERROR (qtp996885049-7338) [n:127.0.0.1:52025_solr    ] o.a.s.h.a.CollectionsHandler
Timed out waiting for new collection's replicas to become ACTIVE with timeout=30
   [junit4]   2> 1242570 INFO  (qtp996885049-7338) [n:127.0.0.1:52025_solr    ] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/collections params={replicationFactor=1&property.solr.tests.ramBufferSizeMB=100&property.solr.tests.mergePolicyFactory=org.apache.solr.index.TieredMergePolicyFactory&property.solr.tests.useMergePolicyFactory=true&property.solr.tests.useMergePolicy=false&version=2&property.solr.tests.mergeScheduler=org.apache.lucene.index.ConcurrentMergeScheduler&property.config=solrconfig-tlog.xml&property.solr.tests.maxBufferedDocs=100000&name=testkerberoscollection&action=CREATE&numShards=1&property.solr.directoryFactory=solr.RAMDirectoryFactory&wt=javabin}
status=0 QTime=31313
   [junit4]   2> 1242588 WARN  (TEST-TestSolrCloudWithKerberosAlt.testBasics-seed#[4E6CEC3CD492BFE4])
[    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: hadoop.auth="u=solr&p=solr@EXAMPLE.COM&t=kerberos-dt&e=1476120079073&s=0u5a3E40oWIy+4oRqZvWB0Bk+I8=";
Path=/; Domain=127.0.0.1; Expires=Mo, 10-Okt-2016 17:21:19 GMT; HttpOnly". Invalid 'expires'
attribute: Mo, 10-Okt-2016 17:21:19 GMT
   [junit4]   2> 1242589 WARN  (TEST-TestSolrCloudWithKerberosAlt.testBasics-seed#[4E6CEC3CD492BFE4]-SendThread(127.0.0.1:52023))
[    ] o.a.z.ClientCnxn SASL configuration failed: javax.security.auth.login.LoginException:
No JAAS configuration section named 'Client' was found in specified JAAS configuration file:
'/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.TestSolrCloudWithKerberosAlt_4E6CEC3CD492BFE4-001/tempDir-001/minikdc/jaas-client.conf'.
Will continue connection to Zookeeper server without SASL authentication, if Zookeeper server
allows it.
   [junit4]   2> 1242590 WARN  (zkCallback-1352-thread-1) [    ] o.a.s.c.c.ConnectionManager
Watcher org.apache.solr.common.cloud.ConnectionManager@7e37cfc8 name: ZooKeeperConnection
Watcher:127.0.0.1:52023/solr got event WatchedEvent state:AuthFailed type:None path:null path:
null type: None
   [junit4]   2> 1242590 WARN  (zkCallback-1352-thread-1) [    ] o.a.s.c.c.ConnectionManager
zkClient received AuthFailed
   [junit4]   2> 1242609 INFO  (TEST-TestSolrCloudWithKerberosAlt.testBasics-seed#[4E6CEC3CD492BFE4])
[    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1242611 INFO  (TEST-TestSolrCloudWithKerberosAlt.testBasics-seed#[4E6CEC3CD492BFE4])
[    ] o.a.s.c.AbstractDistribZkTestBase Wait for recoveries to finish - collection: testkerberoscollection
failOnTimeout:true timeout (sec):330
   [junit4]   1> -
   [junit4]   2> 1242656 INFO  (jetty-launcher-1339-thread-1) [    ] o.e.j.s.ServerConnector
Stopped ServerConnector@2f757efd{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1242657 INFO  (jetty-launcher-1339-thread-1) [    ] o.a.s.c.CoreContainer
Shutting down CoreContainer instance=2074323711
   [junit4]   2> 1242689 INFO  (jetty-launcher-1339-thread-1) [    ] o.a.s.c.Overseer Overseer
(id=96736645590089731-127.0.0.1:52025_solr-n_0000000000) closing
   [junit4]   2> 1242689 INFO  (OverseerStateUpdate-96736645590089731-127.0.0.1:52025_solr-n_0000000000)
[n:127.0.0.1:52025_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:52025_solr
   [junit4]   2> 1244202 WARN  (zkCallback-1345-thread-3-processing-n:127.0.0.1:52025_solr)
[n:127.0.0.1:52025_solr    ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot
talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
   [junit4]   2> 1244203 ERROR (Thread[Thread-1610,5,TGRP-TestSolrCloudWithKerberosAlt])
[n:127.0.0.1:52025_solr    ] o.a.h.s.t.d.AbstractDelegationTokenSecretManager ExpiredTokenRemover
received java.lang.InterruptedException: sleep interrupted
   [junit4]   2> 1244265 INFO  (jetty-launcher-1339-thread-1) [    ] o.e.j.s.h.ContextHandler
Stopped o.e.j.s.ServletContextHandler@3c9af2cf{/solr,null,UNAVAILABLE}
   [junit4]   2> 1244267 INFO  (TEST-TestSolrCloudWithKerberosAlt.testBasics-seed#[4E6CEC3CD492BFE4])
[    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:52023 52023
   [junit4]   2> 1244382 INFO  (Thread-1601) [    ] o.a.s.c.ZkTestServer connecting to
127.0.0.1:52023 52023
   [junit4]   2> 1252137 WARN  (Thread-1601) [    ] o.a.s.c.ZkTestServer Watch limit violations:

   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2> 	3	/solr/aliases.json
   [junit4]   2> 	3	/solr/clusterprops.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2> 	3	/solr/clusterstate.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2> 	39	/solr/overseer/collection-queue-work
   [junit4]   2> 	3	/solr/overseer/queue
   [junit4]   2> 	3	/solr/live_nodes
   [junit4]   2> 	3	/solr/collections
   [junit4]   2> 
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestSolrCloudWithKerberosAlt
-Dtests.method=testBasics -Dtests.seed=4E6CEC3CD492BFE4 -Dtests.slow=true -Dtests.locale=de-AT
-Dtests.timezone=Asia/Chongqing -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
   [junit4] FAILURE 72.4s J1 | TestSolrCloudWithKerberosAlt.testBasics <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: Could not find collection:testkerberoscollection
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([4E6CEC3CD492BFE4:73B44210EC7CE194]:0)
   [junit4]    > 	at org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:153)
   [junit4]    > 	at org.apache.solr.cloud.TestSolrCloudWithKerberosAlt.testCollectionCreateSearchDelete(TestSolrCloudWithKerberosAlt.java:206)
   [junit4]    > 	at org.apache.solr.cloud.TestSolrCloudWithKerberosAlt.testBasics(TestSolrCloudWithKerberosAlt.java:152)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> NOTE: leaving temporary files on disk at: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.TestSolrCloudWithKerberosAlt_4E6CEC3CD492BFE4-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=1604,
maxMBSortInHeap=7.4267036305939405, sim=ClassicSimilarity, locale=de-AT, timezone=Asia/Chongqing
   [junit4]   2> NOTE: Mac OS X 10.11.6 x86_64/Oracle Corporation 1.8.0_102 (64-bit)/cpus=3,threads=1,free=100297008,total=334483456
   [junit4]   2> NOTE: All tests run in this JVM: [SolrCloudExampleTest, TestManagedSchemaAPI,
SpellingQueryConverterTest, CloudMLTQParserTest, BlockDirectoryTest, ReplicationFactorTest,
BJQParserTest, TestClassicSimilarityFactory, TestSchemaManager, SolrCoreCheckLockOnStartupTest,
SignatureUpdateProcessorFactoryTest, TestUseDocValuesAsStored2, TestFieldSortValues, TestConfigSetsAPIZkFailure,
CircularListTest, GraphQueryTest, TestMaxScoreQueryParser, TestQuerySenderListener, JSONWriterTest,
TestFileDictionaryLookup, SolrInfoMBeanTest, TestLeaderInitiatedRecoveryThread, TestDistributedMissingSort,
EnumFieldTest, AddBlockUpdateTest, HdfsRecoveryZkTest, IndexSchemaTest, TestDocSet, TestSystemIdResolver,
AliasIntegrationTest, TestSolrFieldCacheMBean, TestMacroExpander, TestHdfsUpdateLog, TestSolrCoreProperties,
SolrIndexSplitterTest, TestAuthorizationFramework, TestStressUserVersions, TestSmileRequest,
TestDistribDocBasedVersion, DirectoryFactoryTest, ParsingFieldUpdateProcessorsTest, ConnectionReuseTest,
TestXmlQParser, StatsReloadRaceTest, FileBasedSpellCheckerTest, OverseerStatusTest, SpellCheckCollatorTest,
TestDynamicFieldResource, TestDistributedGrouping, AnalyticsQueryTest, TestZkChroot, BooleanFieldTest,
TestDefaultSearchFieldResource, TestPHPSerializedResponseWriter, TestCodecSupport, SecurityConfHandlerTest,
DistributedVersionInfoTest, TestJoin, HdfsNNFailoverTest, TestEmbeddedSolrServerConstructors,
TestSchemaResource, QueryParsingTest, FacetPivotSmallTest, TestCollationFieldDocValues, CdcrReplicationHandlerTest,
TestSolrQueryParser, FullHLLTest, OverriddenZkACLAndCredentialsProvidersTest, TestConfigSetsAPI,
TestSubQueryTransformerCrossCore, TestBadConfig, TestOrdValues, BadComponentTest, TestSizeLimitedDistributedMap,
TestSlowCompositeReaderWrapper, NotRequiredUniqueKeyTest, DistributedTermsComponentTest, DistribCursorPagingTest,
NoCacheHeaderTest, EchoParamsTest, SortSpecParsingTest, CleanupOldIndexTest, HdfsChaosMonkeySafeLeaderTest,
SpellPossibilityIteratorTest, BigEndianAscendingWordDeserializerTest, TestGraphTermsQParserPlugin,
TestQueryUtils, UUIDFieldTest, TestMiniSolrCloudClusterSSL, TestBinaryResponseWriter, TestInitQParser,
TestFoldingMultitermQuery, TestRecoveryHdfs, TestAuthenticationFramework, DistributedFacetPivotLargeTest,
TestFuzzyAnalyzedSuggestions, RequestLoggingTest, TestReplicationHandlerBackup, ShardRoutingCustomTest,
TestOmitPositions, TestObjectReleaseTracker, TestReversedWildcardFilterFactory, DeleteShardTest,
DefaultValueUpdateProcessorTest, BasicAuthIntegrationTest, DirectUpdateHandlerOptimizeTest,
TestRandomFlRTGCloud, TestTolerantUpdateProcessorCloud, WordBreakSolrSpellCheckerTest, MergeStrategyTest,
TestDistributedStatsComponentCardinality, ClusterStateTest, TestQueryWrapperFilter, TestRebalanceLeaders,
DocExpirationUpdateProcessorFactoryTest, CurrencyFieldOpenExchangeTest, TestRecovery, PreAnalyzedFieldTest,
DebugComponentTest, RollingRestartTest, ClassificationUpdateProcessorFactoryTest, HdfsBasicDistributedZkTest,
RemoteQueryErrorTest, TestBackupRepositoryFactory, TestAnalyzedSuggestions, HighlighterConfigTest,
BitVectorTest, TestSolrXml, ConfigSetsAPITest, TestNoOpRegenerator, TestSolrCloudWithKerberosAlt]
   [junit4] Completed [247/635 (1!)] on J1 in 72.42s, 1 test, 1 failure <<< FAILURES!

[...truncated 61624 lines...]


Mime
View raw message