Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Solaris/107/ Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseSerialGC
1 tests failed. FAILED: org.apache.solr.security.TestAuthorizationFramework.authorizationFrameworkTest Error Message: There are still nodes recoverying - waited for 10 seconds Stack Trace: java.lang.AssertionError: There are still nodes recoverying - waited for 10 seconds at __randomizedtesting.SeedInfo.seed([1304894F67198F46:5DA7FC9C76C29E56]:0) at org.junit.Assert.fail(Assert.java:93) at org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:172) at org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForRecoveriesToFinish(AbstractFullDistribZkTestBase.java:836) at org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForThingsToLevelOut(AbstractFullDistribZkTestBase.java:1393) at org.apache.solr.security.TestAuthorizationFramework.authorizationFrameworkTest(TestAuthorizationFramework.java:59) 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:497) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1665) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:864) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:900) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:914) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:963) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:938) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) 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:873) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:775) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:809) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:820) 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:46) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) 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:54) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) 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 11204 lines...] [junit4] Suite: org.apache.solr.security.TestAuthorizationFramework [junit4] 2> Creating dataDir: /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/init-core-data-001 [junit4] 2> 2675793 INFO (SUITE-TestAuthorizationFramework-seed#[1304894F67198F46]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) [junit4] 2> 2675793 INFO (SUITE-TestAuthorizationFramework-seed#[1304894F67198F46]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /pg_/ [junit4] 2> 2675797 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 2675797 INFO (Thread-10995) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 2675797 INFO (Thread-10995) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 2675897 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.ZkTestServer start zk server on port:54269 [junit4] 2> 2675897 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 2675897 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2675901 INFO (zkCallback-2777-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@54942187 name:ZooKeeperConnection Watcher:127.0.0.1:54269 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2675901 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2675901 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 2675901 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 2675905 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 2675906 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2675907 INFO (zkCallback-2778-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1404208b name:ZooKeeperConnection Watcher:127.0.0.1:54269/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2675908 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2675908 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 2675908 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1 [junit4] 2> 2675910 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards [junit4] 2> 2675913 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection [junit4] 2> 2675915 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards [junit4] 2> 2675917 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.AbstractZkTestCase put /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml [junit4] 2> 2675917 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml [junit4] 2> 2675922 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.AbstractZkTestCase put /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml [junit4] 2> 2675922 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml [junit4] 2> 2675925 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.AbstractZkTestCase put /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 2675925 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 2675928 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.AbstractZkTestCase put /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt [junit4] 2> 2675928 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt [junit4] 2> 2675931 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.AbstractZkTestCase put /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt [junit4] 2> 2675931 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt [junit4] 2> 2675934 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.AbstractZkTestCase put /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml [junit4] 2> 2675934 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml [junit4] 2> 2675937 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.AbstractZkTestCase put /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml [junit4] 2> 2675938 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 2675941 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.AbstractZkTestCase put /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json [junit4] 2> 2675941 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 2675945 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.AbstractZkTestCase put /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 2675945 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 2675948 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.AbstractZkTestCase put /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt [junit4] 2> 2675948 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 2675951 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.AbstractZkTestCase put /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt [junit4] 2> 2675952 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt [junit4] 2> 2675956 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 2675957 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2675958 INFO (zkCallback-2779-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5e9de9c4 name:ZooKeeperConnection Watcher:127.0.0.1:54269/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2675959 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2675959 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 2676106 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/control-001/cores/collection1 [junit4] 2> 2676107 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.e.j.s.Server jetty-9.2.13.v20150730 [junit4] 2> 2676109 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@692d537b{/pg_,null,AVAILABLE} [junit4] 2> 2676109 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.e.j.s.ServerConnector Started ServerConnector@24afab4a{HTTP/1.1}{127.0.0.1:63883} [junit4] 2> 2676109 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.e.j.s.Server Started @2679625ms [junit4] 2> 2676109 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/tempDir-001/control/data, hostContext=/pg_, hostPort=63883, coreRootDirectory=/export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/control-001/cores} [junit4] 2> 2676110 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@659e0bfd [junit4] 2> 2676110 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/control-001/' [junit4] 2> 2676131 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 2676131 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2676133 INFO (zkCallback-2780-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3d0a0130 name:ZooKeeperConnection Watcher:127.0.0.1:54269/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2676133 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2676133 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 2676135 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 2676135 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/control-001/solr.xml [junit4] 2> 2676140 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/control-001/cores [junit4] 2> 2676140 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.CoreContainer New CoreContainer 1025843468 [junit4] 2> 2676140 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/control-001/] [junit4] 2> 2676140 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.CoreContainer loading shared library: /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/control-001/lib [junit4] 2> 2676140 WARN (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/control-001/lib). [junit4] 2> 2676148 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] 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,useRetries : false, [junit4] 2> 2676149 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 2676149 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 2676149 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 2676149 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:54269/solr [junit4] 2> 2676149 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 2676149 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 2676150 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2676152 INFO (zkCallback-2782-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@76acc564 name:ZooKeeperConnection Watcher:127.0.0.1:54269 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2676152 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2676152 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 2676154 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2676156 INFO (zkCallback-2783-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@26860770 name:ZooKeeperConnection Watcher:127.0.0.1:54269/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2676156 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2676157 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue [junit4] 2> 2676160 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work [junit4] 2> 2676165 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running [junit4] 2> 2676168 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed [junit4] 2> 2676171 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure [junit4] 2> 2676175 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 2676178 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 2676180 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 2676182 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:63883_pg_ [junit4] 2> 2676183 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:63883_pg_ [junit4] 2> 2676186 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect [junit4] 2> 2676188 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election [junit4] 2> 2676190 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2676191 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/94651412697579525-127.0.0.1:63883_pg_-n_0000000000 [junit4] 2> 2676191 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:63883_pg_ [junit4] 2> 2676191 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader [junit4] 2> 2676194 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.c.Overseer Overseer (id=94651412697579525-127.0.0.1:63883_pg_-n_0000000000) starting [junit4] 2> 2676197 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work [junit4] 2> 2676207 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 2676208 INFO (OverseerCollectionConfigSetProcessor-94651412697579525-127.0.0.1:63883_pg_-n_0000000000) [n:127.0.0.1:63883_pg_ ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations [junit4] 2> 2676208 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 2676209 INFO (OverseerStateUpdate-94651412697579525-127.0.0.1:63883_pg_-n_0000000000) [n:127.0.0.1:63883_pg_ ] o.a.s.c.Overseer Starting to work on the main queue [junit4] 2> 2676223 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.c.CoreContainer Initializing authorization plugin: org.apache.solr.security.MockAuthorizationPlugin [junit4] 2> 2676223 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 2676224 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.c.CoresLocator Looking for core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/control-001/cores [junit4] 2> 2676225 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, instanceDir=/export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/control-001/cores/collection1, collection=control_collection, absoluteInstDir=/export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/control-001/cores/collection1/, coreNodeName=, dataDir=data/, shard=} [junit4] 2> 2676225 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.c.CoresLocator Found core collection1 in /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/control-001/cores/collection1/ [junit4] 2> 2676225 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.c.CoresLocator Found 1 core definitions [junit4] 2> 2676226 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.s.SolrDispatchFilter user.dir=/export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1 [junit4] 2> 2676226 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:63883_pg_ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 2676227 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection x:collection1] o.a.s.c.ZkController publishing state=down [junit4] 2> 2676227 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 2676230 INFO (OverseerStateUpdate-94651412697579525-127.0.0.1:63883_pg_-n_0000000000) [n:127.0.0.1:63883_pg_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:63883/pg_", [junit4] 2> "node_name":"127.0.0.1:63883_pg_", [junit4] 2> "numShards":"1", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} current state version: 0 [junit4] 2> 2676230 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection x:collection1] o.a.s.c.ZkController look for our core node name [junit4] 2> 2676231 INFO (OverseerStateUpdate-94651412697579525-127.0.0.1:63883_pg_-n_0000000000) [n:127.0.0.1:63883_pg_ ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={ [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:63883/pg_", [junit4] 2> "node_name":"127.0.0.1:63883_pg_", [junit4] 2> "numShards":"1", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 2676232 INFO (OverseerStateUpdate-94651412697579525-127.0.0.1:63883_pg_-n_0000000000) [n:127.0.0.1:63883_pg_ ] o.a.s.c.o.ClusterStateMutator building a new cName: control_collection [junit4] 2> 2676233 INFO (OverseerStateUpdate-94651412697579525-127.0.0.1:63883_pg_-n_0000000000) [n:127.0.0.1:63883_pg_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1 [junit4] 2> 2676235 INFO (zkCallback-2783-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1) [junit4] 2> 2677232 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection x:collection1] o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1 [junit4] 2> 2677232 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection x:collection1] o.a.s.c.ZkController Check for collection zkNode:control_collection [junit4] 2> 2677233 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection x:collection1] o.a.s.c.ZkController Collection zkNode exists [junit4] 2> 2677233 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection x:collection1] o.a.s.c.c.ZkStateReader Load collection config from:/collections/control_collection [junit4] 2> 2677234 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection x:collection1] o.a.s.c.c.ZkStateReader path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper [junit4] 2> 2677234 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection x:collection1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/control-001/cores/collection1/' [junit4] 2> 2677252 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection x:collection1] o.a.s.c.Config loaded config solrconfig.xml with version 0 [junit4] 2> 2677257 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 2677260 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.4.0 [junit4] 2> 2677265 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection x:collection1] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml [junit4] 2> 2677266 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection x:collection1] o.a.s.s.IndexSchema Reading Solr Schema from /configs/conf1/schema.xml [junit4] 2> 2677270 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 2677348 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 2677353 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection x:collection1] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 2677353 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection x:collection1] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 2677365 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 2677367 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 2677369 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2677370 WARN (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE [junit4] 2> 2677370 WARN (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING [junit4] 2> 2677370 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2677371 WARN (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE [junit4] 2> 2677371 WARN (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING [junit4] 2> 2677372 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection x:collection1] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/configs/conf1', cwd=/export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1 [junit4] 2> 2677372 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection control_collection [junit4] 2> 2677372 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 2677373 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/control-001/cores/collection1/], dataDir=[null] [junit4] 2> 2677373 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@6ee343db [junit4] 2> 2677373 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/control-001/cores/collection1/data [junit4] 2> 2677373 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/control-001/cores/collection1/data/index/ [junit4] 2> 2677373 WARN (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/control-001/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 2677373 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/control-001/cores/collection1/data/index [junit4] 2> 2677374 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=45, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=16.1708984375, floorSegmentMB=1.2626953125, forceMergeDeletesPctAllowed=28.317650249263544, segmentsPerTier=20.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 2677374 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@2681341 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1114805d),segFN=segments_1,generation=1} [junit4] 2> 2677374 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 2677374 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/control-001/cores/collection1/data/ [junit4] 2> 2677375 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.DirectoryFactory /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/control-001/cores/collection1/data/ does not point to a valid data directory; skipping clean-up of old index directories. [junit4] 2> 2677378 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "nodistrib" [junit4] 2> 2677378 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe" [junit4] 2> 2677378 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 2677378 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig" [junit4] 2> 2677379 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 2677379 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 2677379 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 2677379 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 2677379 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 2677381 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 2677381 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 2677382 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 2677383 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 2677386 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file [junit4] 2> 2677386 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 2677387 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2677387 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 2677388 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled [junit4] 2> 2677388 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled [junit4] 2> 2677388 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=16, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8047932874567846] [junit4] 2> 2677388 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@2681341 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1114805d),segFN=segments_1,generation=1} [junit4] 2> 2677388 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 2677388 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@29074f59[collection1] main [junit4] 2> 2677388 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.ZkStateReader Load collection config from:/collections/control_collection [junit4] 2> 2677389 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.ZkStateReader path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper [junit4] 2> 2677389 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1 [junit4] 2> 2677390 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 2677390 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {} [junit4] 2> 2677390 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 2677391 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage No data found for znode /configs/conf1/_rest_managed.json [junit4] 2> 2677391 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 2677391 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 2677391 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 2677391 INFO (searcherExecutor-9484-thread-1-processing-n:127.0.0.1:63883_pg_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@29074f59[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2677391 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets [junit4] 2> 2677392 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version buckets from index [junit4] 2> 2677392 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket highest value from index [junit4] 2> 2677392 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1514422604831653888 [junit4] 2> 2677393 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Took 1.0ms to seed version buckets with highest version 1514422604831653888 [junit4] 2> 2677393 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1 [junit4] 2> 2677394 INFO (coreLoadExecutor-9483-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 2677394 INFO (coreZkRegister-9477-thread-1-processing-n:127.0.0.1:63883_pg_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController Register replica - core:collection1 address:http://127.0.0.1:63883/pg_ collection:control_collection shard:shard1 [junit4] 2> 2677396 INFO (coreZkRegister-9477-thread-1-processing-n:127.0.0.1:63883_pg_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leader_elect/shard1/election [junit4] 2> 2677400 INFO (coreZkRegister-9477-thread-1-processing-n:127.0.0.1:63883_pg_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.LeaderElector Joined leadership election with path: /collections/control_collection/leader_elect/shard1/election/94651412697579525-core_node1-n_0000000000 [junit4] 2> 2677401 INFO (coreZkRegister-9477-thread-1-processing-n:127.0.0.1:63883_pg_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Running the leader process for shard shard1 [junit4] 2> 2677403 INFO (coreZkRegister-9477-thread-1-processing-n:127.0.0.1:63883_pg_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 2677403 INFO (coreZkRegister-9477-thread-1-processing-n:127.0.0.1:63883_pg_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 2677403 INFO (coreZkRegister-9477-thread-1-processing-n:127.0.0.1:63883_pg_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:63883/pg_/collection1/ [junit4] 2> 2677403 INFO (coreZkRegister-9477-thread-1-processing-n:127.0.0.1:63883_pg_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 2677403 INFO (coreZkRegister-9477-thread-1-processing-n:127.0.0.1:63883_pg_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:63883/pg_/collection1/ has no replicas [junit4] 2> 2677403 INFO (coreZkRegister-9477-thread-1-processing-n:127.0.0.1:63883_pg_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:63883/pg_/collection1/ shard1 [junit4] 2> 2677404 INFO (OverseerStateUpdate-94651412697579525-127.0.0.1:63883_pg_-n_0000000000) [n:127.0.0.1:63883_pg_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"leader", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection"} current state version: 1 [junit4] 2> 2677404 INFO (coreZkRegister-9477-thread-1-processing-n:127.0.0.1:63883_pg_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1 [junit4] 2> 2677409 INFO (coreZkRegister-9477-thread-1-processing-n:127.0.0.1:63883_pg_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node [junit4] 2> 2677412 INFO (OverseerStateUpdate-94651412697579525-127.0.0.1:63883_pg_-n_0000000000) [n:127.0.0.1:63883_pg_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"leader", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "base_url":"http://127.0.0.1:63883/pg_", [junit4] 2> "core":"collection1", [junit4] 2> "state":"active"} current state version: 1 [junit4] 2> 2677515 INFO (zkCallback-2783-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1) [junit4] 2> 2677563 INFO (coreZkRegister-9477-thread-1-processing-n:127.0.0.1:63883_pg_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController We are http://127.0.0.1:63883/pg_/collection1/ and leader is http://127.0.0.1:63883/pg_/collection1/ [junit4] 2> 2677563 INFO (coreZkRegister-9477-thread-1-processing-n:127.0.0.1:63883_pg_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:63883/pg_ [junit4] 2> 2677563 INFO (coreZkRegister-9477-thread-1-processing-n:127.0.0.1:63883_pg_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 2677563 INFO (coreZkRegister-9477-thread-1-processing-n:127.0.0.1:63883_pg_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController publishing state=active [junit4] 2> 2677563 INFO (coreZkRegister-9477-thread-1-processing-n:127.0.0.1:63883_pg_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:63883_pg_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 2677566 INFO (OverseerStateUpdate-94651412697579525-127.0.0.1:63883_pg_-n_0000000000) [n:127.0.0.1:63883_pg_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "core":"collection1", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:63883/pg_", [junit4] 2> "node_name":"127.0.0.1:63883_pg_", [junit4] 2> "numShards":"1", [junit4] 2> "state":"active", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} current state version: 2 [junit4] 2> 2677567 INFO (OverseerStateUpdate-94651412697579525-127.0.0.1:63883_pg_-n_0000000000) [n:127.0.0.1:63883_pg_ ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={ [junit4] 2> "core":"collection1", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:63883/pg_", [junit4] 2> "node_name":"127.0.0.1:63883_pg_", [junit4] 2> "numShards":"1", [junit4] 2> "state":"active", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 2677670 INFO (zkCallback-2783-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1) [junit4] 2> 2677730 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 2677731 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2677733 INFO (zkCallback-2785-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@575435b6 name:ZooKeeperConnection Watcher:127.0.0.1:54269/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2677733 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2677733 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 2677733 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 2677737 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false [junit4] 2> 2677888 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/shard-1-001/cores/collection1 [junit4] 2> 2677889 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/shard-1-001 [junit4] 2> 2677890 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.e.j.s.Server jetty-9.2.13.v20150730 [junit4] 2> 2677893 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@68b87030{/pg_,null,AVAILABLE} [junit4] 2> 2677893 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.e.j.s.ServerConnector Started ServerConnector@35bfad02{HTTP/1.1}{127.0.0.1:47928} [junit4] 2> 2677893 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.e.j.s.Server Started @2681409ms [junit4] 2> 2677893 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/tempDir-001/jetty1, solrconfig=solrconfig.xml, hostContext=/pg_, hostPort=47928, coreRootDirectory=/export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/../../../../../../../../../../export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/shard-1-001/cores} [junit4] 2> 2677894 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@659e0bfd [junit4] 2> 2677894 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/../../../../../../../../../../export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/shard-1-001/' [junit4] 2> 2677919 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 2677920 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2677921 INFO (zkCallback-2786-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@207363eb name:ZooKeeperConnection Watcher:127.0.0.1:54269/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2677921 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2677922 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 2677923 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 2677923 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/../../../../../../../../../../export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/shard-1-001/solr.xml [junit4] 2> 2677927 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/../../../../../../../../../../export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/shard-1-001/cores [junit4] 2> 2677928 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.CoreContainer New CoreContainer 718126866 [junit4] 2> 2677928 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/../../../../../../../../../../export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/shard-1-001/] [junit4] 2> 2677928 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.CoreContainer loading shared library: /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/../../../../../../../../../../export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/shard-1-001/lib [junit4] 2> 2677928 WARN (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/../../../../../../../../../../export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/shard-1-001/lib). [junit4] 2> 2677939 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] 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,useRetries : false, [junit4] 2> 2677941 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 2677941 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 2677941 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 2677941 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:54269/solr [junit4] 2> 2677941 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 2677942 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 2677942 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2677944 INFO (zkCallback-2788-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2dd8f9fc name:ZooKeeperConnection Watcher:127.0.0.1:54269 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2677944 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2677944 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 2677946 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:47928_pg_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2677948 INFO (zkCallback-2789-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@610d43a9 name:ZooKeeperConnection Watcher:127.0.0.1:54269/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2677948 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:47928_pg_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2677957 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:47928_pg_ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 2678966 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:47928_pg_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:47928_pg_ [junit4] 2> 2678967 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:47928_pg_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:47928_pg_ [junit4] 2> 2678969 INFO (zkCallback-2783-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 1) [junit4] 2> 2678969 INFO (zkCallback-2785-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 1) [junit4] 2> 2678970 INFO (zkCallback-2789-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 1) [junit4] 2> 2678973 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:47928_pg_ ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2678974 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:47928_pg_ ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/94651412697579529-127.0.0.1:47928_pg_-n_0000000001 [junit4] 2> 2678975 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:47928_pg_ ] o.a.s.c.LeaderElector Watching path /overseer_elect/election/94651412697579525-127.0.0.1:63883_pg_-n_0000000000 to know if I could be the leader [junit4] 2> 2678978 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:47928_pg_ ] o.a.s.c.CoreContainer Initializing authorization plugin: org.apache.solr.security.MockAuthorizationPlugin [junit4] 2> 2678978 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:47928_pg_ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 2678980 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:47928_pg_ ] o.a.s.c.CoresLocator Looking for core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/../../../../../../../../../../export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/shard-1-001/cores [junit4] 2> 2678982 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:47928_pg_ ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, instanceDir=/export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/../../../../../../../../../../export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/shard-1-001/cores/collection1, collection=collection1, absoluteInstDir=/export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/../../../../../../../../../../export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/shard-1-001/cores/collection1/, coreNodeName=, dataDir=data/, shard=} [junit4] 2> 2678982 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:47928_pg_ ] o.a.s.c.CoresLocator Found core collection1 in /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/../../../../../../../../../../export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/shard-1-001/cores/collection1/ [junit4] 2> 2678982 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:47928_pg_ ] o.a.s.c.CoresLocator Found 1 core definitions [junit4] 2> 2678983 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:47928_pg_ ] o.a.s.s.SolrDispatchFilter user.dir=/export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1 [junit4] 2> 2678983 INFO (TEST-TestAuthorizationFramework.authorizationFrameworkTest-seed#[1304894F67198F46]) [n:127.0.0.1:47928_pg_ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 2678984 INFO (coreLoadExecutor-9494-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ c:collection1 x:collection1] o.a.s.c.ZkController publishing state=down [junit4] 2> 2678984 INFO (coreLoadExecutor-9494-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ c:collection1 x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 2678987 INFO (OverseerStateUpdate-94651412697579525-127.0.0.1:63883_pg_-n_0000000000) [n:127.0.0.1:63883_pg_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:47928/pg_", [junit4] 2> "node_name":"127.0.0.1:47928_pg_", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"collection1", [junit4] 2> "operation":"state"} current state version: 3 [junit4] 2> 2678987 INFO (coreLoadExecutor-9494-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ c:collection1 x:collection1] o.a.s.c.ZkController look for our core node name [junit4] 2> 2678988 INFO (OverseerStateUpdate-94651412697579525-127.0.0.1:63883_pg_-n_0000000000) [n:127.0.0.1:63883_pg_ ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={ [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:47928/pg_", [junit4] 2> "node_name":"127.0.0.1:47928_pg_", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"collection1", [junit4] 2> "operation":"state"} [junit4] 2> 2678988 INFO (OverseerStateUpdate-94651412697579525-127.0.0.1:63883_pg_-n_0000000000) [n:127.0.0.1:63883_pg_ ] o.a.s.c.o.ClusterStateMutator building a new cName: collection1 [junit4] 2> 2678988 INFO (OverseerStateUpdate-94651412697579525-127.0.0.1:63883_pg_-n_0000000000) [n:127.0.0.1:63883_pg_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard2 [junit4] 2> 2679092 INFO (zkCallback-2785-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2) [junit4] 2> 2679092 INFO (zkCallback-2789-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2) [junit4] 2> 2679092 INFO (zkCallback-2783-thread-1-processing-n:127.0.0.1:63883_pg_) [n:127.0.0.1:63883_pg_ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2) [junit4] 2> 2679994 INFO (coreLoadExecutor-9494-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ c:collection1 x:collection1] o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1 [junit4] 2> 2679994 INFO (coreLoadExecutor-9494-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ c:collection1 x:collection1] o.a.s.c.ZkController Check for collection zkNode:collection1 [junit4] 2> 2679995 INFO (coreLoadExecutor-9494-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ c:collection1 x:collection1] o.a.s.c.ZkController Collection zkNode exists [junit4] 2> 2679995 INFO (coreLoadExecutor-9494-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ c:collection1 x:collection1] o.a.s.c.c.ZkStateReader Load collection config from:/collections/collection1 [junit4] 2> 2679996 INFO (coreLoadExecutor-9494-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ c:collection1 x:collection1] o.a.s.c.c.ZkStateReader path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper [junit4] 2> 2679996 INFO (coreLoadExecutor-9494-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ c:collection1 x:collection1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/../../../../../../../../../../export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001/shard-1-001/cores/collection1/' [junit4] 2> 2680033 INFO (coreLoadExecutor-9494-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ c:collection1 x:collection1] o.a.s.c.Config loaded config solrconfig.xml with version 0 [junit4] 2> 2680038 INFO (coreLoadExecutor-9494-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ c:collection1 x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 2680041 INFO (coreLoadExecutor-9494-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ c:collection1 x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.4.0 [junit4] 2> 2680050 INFO (coreLoadExecutor-9494-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ c:collection1 x:collection1] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml [junit4] 2> 2680051 INFO (coreLoadExecutor-9494-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ c:collection1 x:collection1] o.a.s.s.IndexSchema Reading Solr Schema from /configs/conf1/schema.xml [junit4] 2> 2680057 INFO (coreLoadExecutor-9494-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ c:collection1 x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 2680169 INFO (coreLoadExecutor-9494-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ c:collection1 x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 2680174 INFO (coreLoadExecutor-9494-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ c:collection1 x:collection1] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 2680175 INFO (coreLoadExecutor-9494-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ c:collection1 x:collection1] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 2680186 INFO (coreLoadExecutor-9494-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ c:collection1 x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 2680188 INFO (coreLoadExecutor-9494-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ c:collection1 x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 2680190 INFO (coreLoadExecutor-9494-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ c:collection1 x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2680191 WARN (coreLoadExecutor-9494-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ c:collection1 x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE [junit4] 2> 2680192 WARN (coreLoadExecutor-9494-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ c:collection1 x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING [junit4] 2> 2680192 INFO (coreLoadExecutor-9494-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ c:collection1 x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2680193 WARN (coreLoadExecutor-9494-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ c:collection1 x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE [junit4] 2> 2680193 WARN (coreLoadExecutor-9494-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ c:collection1 x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING [junit4] 2> 2680194 INFO (coreLoadExecutor-9494-thread-1-processing-n:127.0.0.1:47928_pg_) [n:127.0.0.1:47928_pg_ c:collection1 x:collection1] o. [...truncated too long message...] tches above limit: [junit4] 2> [junit4] 2> 6 /solr/live_nodes [junit4] 2> 6 /solr/collections [junit4] 2> 4 /solr/overseer/collection-queue-work [junit4] 2> 3 /solr/overseer/queue [junit4] 2> 2 /solr/overseer/queue-work [junit4] 2> [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestAuthorizationFramework -Dtests.method=authorizationFrameworkTest -Dtests.seed=1304894F67198F46 -Dtests.slow=true -Dtests.locale=hr -Dtests.timezone=Asia/Phnom_Penh -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [junit4] FAILURE 34.8s J1 | TestAuthorizationFramework.authorizationFrameworkTest <<< [junit4] > Throwable #1: java.lang.AssertionError: There are still nodes recoverying - waited for 10 seconds [junit4] > at __randomizedtesting.SeedInfo.seed([1304894F67198F46:5DA7FC9C76C29E56]:0) [junit4] > at org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:172) [junit4] > at org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForRecoveriesToFinish(AbstractFullDistribZkTestBase.java:836) [junit4] > at org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForThingsToLevelOut(AbstractFullDistribZkTestBase.java:1393) [junit4] > at org.apache.solr.security.TestAuthorizationFramework.authorizationFrameworkTest(TestAuthorizationFramework.java:59) [junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:963) [junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:938) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] 2> 2710561 INFO (SUITE-TestAuthorizationFramework-seed#[1304894F67198F46]-worker) [n:127.0.0.1:52184_pg_ c:collection1 s:shard1 r:core_node4 x:collection1] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build/solr-core/test/J1/temp/solr.security.TestAuthorizationFramework_1304894F67198F46-001 [junit4] 2> Oct 08, 2015 12:59:35 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(Lucene53): {}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=false,coord=yes): {}, locale=hr, timezone=Asia/Phnom_Penh [junit4] 2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_60 (64-bit)/cpus=3,threads=1,free=64287664,total=518979584 [junit4] 2> NOTE: All tests run in this JVM: [TestJoin, TestRandomFaceting, TestComplexPhraseQParserPlugin, TestFiltering, TestOverriddenPrefixQueryForCustomFieldType, NoCacheHeaderTest, DataDrivenBlockJoinTest, TestMinMaxOnMultiValuedField, ResponseLogComponentTest, TestPKIAuthenticationPlugin, BigEndianAscendingWordSerializerTest, TestConfigReload, ClusterStateTest, HdfsDirectoryTest, TestFreeTextSuggestions, TestHashQParserPlugin, QueryParsingTest, TestLRUStatsCache, ZkStateReaderTest, SaslZkACLProviderTest, LeaderElectionIntegrationTest, SparseHLLTest, AddSchemaFieldsUpdateProcessorFactoryTest, TestRealTimeGet, TestRangeQuery, DistributedQueryComponentOptimizationTest, TestSolrQueryParser, BasicAuthIntegrationTest, TestConfigSetImmutable, BlockCacheTest, TestImplicitCoreProperties, CollectionStateFormat2Test, PKIAuthenticationIntegrationTest, TestShortCircuitedRequests, TestManagedSynonymFilterFactory, TestAddFieldRealTimeGet, CopyFieldTest, AssignTest, SolrXmlInZkTest, TestIntervalFaceting, DateRangeFieldTest, PreAnalyzedFieldTest, MergeStrategyTest, FullSolrCloudDistribCmdsTest, MultiThreadedOCPTest, TestZkChroot, TestConfigOverlay, TestCoreDiscovery, NumericFieldsTest, TestCopyFieldCollectionResource, SynonymTokenizerTest, DistributedVersionInfoTest, SecurityConfHandlerTest, TestExpandComponent, TestBinaryField, FieldAnalysisRequestHandlerTest, TestSchemaManager, TestJsonRequest, AddBlockUpdateTest, CacheHeaderTest, TestDistributedGrouping, TermVectorComponentTest, TestHighFrequencyDictionaryFactory, TestDistributedMissingSort, HighlighterMaxOffsetTest, RequestLoggingTest, SignatureUpdateProcessorFactoryTest, TestCSVResponseWriter, OpenExchangeRatesOrgProviderTest, TestReload, CollectionsAPIDistributedZkTest, IndexSchemaRuntimeFieldTest, CloudExitableDirectoryReaderTest, SmileWriterTest, TimeZoneUtilsTest, DistributedSuggestComponentTest, TestInfoStreamLogging, LukeRequestHandlerTest, EnumFieldTest, OpenCloseCoreStressTest, DeleteInactiveReplicaTest, DistribCursorPagingTest, TestSuggestSpellingConverter, SliceStateTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, WordBreakSolrSpellCheckerTest, TestDefaultStatsCache, ChaosMonkeySafeLeaderTest, ResponseHeaderTest, TestLMJelinekMercerSimilarityFactory, TestReversedWildcardFilterFactory, ShowFileRequestHandlerTest, BadIndexSchemaTest, DistanceFunctionTest, BasicZkTest, TestMiniSolrCloudClusterSSL, StatsComponentTest, TestSolrQueryParserDefaultOperatorResource, SuggesterTest, TestDynamicFieldResource, TestAtomicUpdateErrorCases, FieldMutatingUpdateProcessorTest, TestIndexSearcher, FacetPivotSmallTest, AutoCommitTest, TestPivotHelperCode, TestDefaultSimilarityFactory, TestUniqueKeyFieldResource, TestSolrDynamicMBean, TestOrdValues, TestClassNameShortening, ConcurrentDeleteAndCreateCollectionTest, TestSchemaVersionResource, ConvertedLegacyTest, RankQueryTest, ReplicationFactorTest, DistributedDebugComponentTest, DefaultValueUpdateProcessorTest, HdfsRecoveryZkTest, CursorPagingTest, BigEndianAscendingWordDeserializerTest, TestStressRecovery, BufferStoreTest, TestSortingResponseWriter, BasicDistributedZk2Test, TermVectorComponentDistributedTest, TestSolrConfigHandlerConcurrent, DebugComponentTest, DeleteShardTest, SuggestComponentTest, TestQueryUtils, RequestHandlersTest, BasicDistributedZkTest, UnloadDistributedZkTest, SyncSliceTest, ShardRoutingTest, TestReplicationHandler, ZkCLITest, TestDistributedSearch, SuggesterTSTTest, SolrCoreCheckLockOnStartupTest, TestRemoteStreaming, IndexBasedSpellCheckerTest, TestWriterPerf, TestOmitPositions, TermsComponentTest, TestIndexingPerformance, TestArbitraryIndexDir, TestCollationField, ReturnFieldsTest, TestAnalyzedSuggestions, TestPHPSerializedResponseWriter, SearchHandlerTest, HighlighterConfigTest, TestQuerySenderListener, AlternateDirectoryTest, TestMergePolicyConfig, MultiTermTest, TestDocSet, TestSearchPerf, MinimalSchemaTest, OutputWriterTest, ExternalFileFieldSortTest, TestSolrCoreProperties, DirectSolrConnectionTest, SpellPossibilityIteratorTest, TestCharFilters, TestCodecSupport, EchoParamsTest, TestPerFieldSimilarity, TestJmxMonitoredMap, TestFastLRUCache, ChaosMonkeyNothingIsSafeTest, CollectionTooManyReplicasTest, DeleteLastCustomShardedReplicaTest, DeleteReplicaTest, DistribDocExpirationUpdateProcessorTest, LeaderInitiatedRecoveryOnShardRestartTest, MigrateRouteKeyTest, RemoteQueryErrorTest, SSLMigrationTest, SharedFSAutoReplicaFailoverTest, SharedFSAutoReplicaFailoverUtilsTest, SimpleCollectionCreateDeleteTest, TestAuthenticationFramework, TestConfigSetsAPI, TestConfigSetsAPIExclusivity, TestConfigSetsAPIZkFailure, TestCryptoKeys, TestLeaderInitiatedRecoveryThread, TestRebalanceLeaders, TriLevelCompositeIdRoutingTest, HdfsRecoverLeaseTest, TestClusterStateMutator, RuleEngineTest, CachingDirectoryFactoryTest, ExitableDirectoryReaderTest, HdfsDirectoryFactoryTest, TestConfigSetProperties, TestConfigSets, TestInitParams, TestNRTOpen, TestReloadAndDeleteDocs, TestShardHandlerFactory, TestSolrXml, TestBlobHandler, TestReqParamsAPI, TestSolrConfigHandlerCloud, DistributedFacetPivotSmallTest, SpatialHeatmapFacetsTest, TestTrackingShardHandlerFactory, JavabinLoaderTest, TestChildDocTransformer, TestManagedResource, TestManagedResourceStorage, TestBulkSchemaAPI, TestDefaultSearchFieldResource, TestFieldCollectionResource, TestFieldResource, TestFieldTypeResource, TestManagedSchemaFieldResource, TestRemoveLastDynamicCopyField, TestSchemaNameResource, TestSchemaResource, TestSchemaSimilarityResource, TestSolrQueryParserResource, BadCopyFieldTest, ChangedSchemaMergeTest, SpatialRPTFieldTypeTest, TestCloudManagedSchema, TestManagedSchema, AnalyticsMergeStrategyTest, CursorMarkTest, TestCollapseQParserPlugin, TestCustomSort, TestFieldSortValues, TestMaxScoreQueryParser, TestNoOpRegenerator, TestRecoveryHdfs, TestSolr4Spatial2, TestJsonFacets, TestNonDefinedSimilarityFactory, TestExactStatsCache, TestAuthorizationFramework] [junit4] Completed [526/540] on J1 in 35.30s, 1 test, 1 failure <<< FAILURES! [...truncated 52 lines...] BUILD FAILED /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/build.xml:785: The following error occurred while executing this line: /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/build.xml:729: The following error occurred while executing this line: /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/build.xml:59: The following error occurred while executing this line: /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/build.xml:233: The following error occurred while executing this line: /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/solr/common-build.xml:526: The following error occurred while executing this line: /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/lucene/common-build.xml:1452: The following error occurred while executing this line: /export/home/jenkins/workspace/Lucene-Solr-5.x-Solaris/lucene/common-build.xml:1006: There were test failures: 540 suites (7 ignored), 2130 tests, 1 failure, 47 ignored (35 assumptions) [seed: 1304894F67198F46] Total time: 67 minutes 21 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts [WARNINGS] Skipping publisher since build result is FAILURE Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org