Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/7969/ Java: 64bit/jdk-13-ea+18 -XX:+UseCompressedOops -XX:+UseG1GC
1 tests failed. FAILED: org.apache.solr.security.BasicAuthIntegrationTest.testBasicAuth Error Message: Error from server at http://127.0.0.1:56022/solr/authCollection: Error from server at null: Expected mime type application/octet-stream but got text/html. <html> <head> <meta http-equiv="Content-Type" content="text/html;charset=utf-8"/> <title>Error 401 require authentication</title> </head> <body><h2>HTTP ERROR 401</h2> <p>Problem accessing /solr/authCollection_shard2_replica_n2/select. Reason: <pre> require authentication</pre></p><hr><a href="http://eclipse.org/jetty";>Powered by Jetty:// 9.4.14.v20181114</a><hr/> </body> </html> Stack Trace: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:56022/solr/authCollection: Error from server at null: Expected mime type application/octet-stream but got text/html. <html> <head> <meta http-equiv="Content-Type" content="text/html;charset=utf-8"/> <title>Error 401 require authentication</title> </head> <body><h2>HTTP ERROR 401</h2> <p>Problem accessing /solr/authCollection_shard2_replica_n2/select. Reason: <pre> require authentication</pre></p><hr><a href="http://eclipse.org/jetty";>Powered by Jetty:// 9.4.14.v20181114</a><hr/> </body> </html> at __randomizedtesting.SeedInfo.seed([54734BA451F87FA9:E81D3DB6F5ABFCD3]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:649) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244) at org.apache.solr.client.solrj.impl.LBSolrClient.doRequest(LBSolrClient.java:368) at org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:296) at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.sendRequest(BaseCloudSolrClient.java:1068) at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:837) at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:769) at org.apache.solr.security.BasicAuthIntegrationTest.testBasicAuth(BasicAuthIntegrationTest.java:290) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:567) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.base/java.lang.Thread.run(Thread.java:835) Build Log: [...truncated 15211 lines...] [junit4] Suite: org.apache.solr.security.BasicAuthIntegrationTest [junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_54734BA451F87FA9-001\init-core-data-001 [junit4] 2> 3484495 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 3 servers in C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_54734BA451F87FA9-001\tempDir-001 [junit4] 2> 3484495 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 3484495 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 3484495 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 3484595 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.c.ZkTestServer start zk server on port:56004 [junit4] 2> 3484595 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:56004 [junit4] 2> 3484595 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 56004 [junit4] 2> 3484609 INFO (zkConnectionManagerCallback-25013-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 3484672 INFO (zkConnectionManagerCallback-25015-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 3484677 INFO (zkConnectionManagerCallback-25017-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 3484719 WARN (jetty-launcher-25018-thread-1) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 3484719 INFO (jetty-launcher-25018-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 3484719 INFO (jetty-launcher-25018-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 3484719 INFO (jetty-launcher-25018-thread-1) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 13-ea+18 [junit4] 2> 3484719 INFO (jetty-launcher-25018-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 3484722 INFO (jetty-launcher-25018-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 3484722 INFO (jetty-launcher-25018-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 3484722 INFO (jetty-launcher-25018-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3efbb1cb{/solr,null,AVAILABLE} [junit4] 2> 3484724 WARN (jetty-launcher-25018-thread-2) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 3484724 INFO (jetty-launcher-25018-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 3484724 INFO (jetty-launcher-25018-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 3484724 INFO (jetty-launcher-25018-thread-2) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 13-ea+18 [junit4] 2> 3484725 INFO (jetty-launcher-25018-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 3484725 INFO (jetty-launcher-25018-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 3484725 INFO (jetty-launcher-25018-thread-2) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 3484725 INFO (jetty-launcher-25018-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2fd3f28a{/solr,null,AVAILABLE} [junit4] 2> 3484725 WARN (jetty-launcher-25018-thread-3) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 3484725 INFO (jetty-launcher-25018-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 3484725 INFO (jetty-launcher-25018-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 3484725 INFO (jetty-launcher-25018-thread-3) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 13-ea+18 [junit4] 2> 3484727 INFO (jetty-launcher-25018-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 3484727 INFO (jetty-launcher-25018-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 3484727 INFO (jetty-launcher-25018-thread-3) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 3484727 INFO (jetty-launcher-25018-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@377bd863{/solr,null,AVAILABLE} [junit4] 2> 3484729 INFO (jetty-launcher-25018-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@2e532308{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:56019} [junit4] 2> 3484729 INFO (jetty-launcher-25018-thread-1) [ ] o.e.j.s.Server Started @3484766ms [junit4] 2> 3484729 INFO (jetty-launcher-25018-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=56019} [junit4] 2> 3484729 ERROR (jetty-launcher-25018-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 3484729 INFO (jetty-launcher-25018-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 3484729 INFO (jetty-launcher-25018-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0 [junit4] 2> 3484729 INFO (jetty-launcher-25018-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 3484729 INFO (jetty-launcher-25018-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 3484729 INFO (jetty-launcher-25018-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-05-31T18:46:30.441589700Z [junit4] 2> 3484731 INFO (jetty-launcher-25018-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@77205b08{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:56022} [junit4] 2> 3484731 INFO (jetty-launcher-25018-thread-2) [ ] o.e.j.s.Server Started @3484769ms [junit4] 2> 3484731 INFO (jetty-launcher-25018-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=56022} [junit4] 2> 3484731 ERROR (jetty-launcher-25018-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 3484731 INFO (jetty-launcher-25018-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 3484731 INFO (jetty-launcher-25018-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0 [junit4] 2> 3484731 INFO (jetty-launcher-25018-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 3484731 INFO (jetty-launcher-25018-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 3484731 INFO (jetty-launcher-25018-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-05-31T18:46:30.443958300Z [junit4] 2> 3484734 INFO (jetty-launcher-25018-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@64e70d8c{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:56025} [junit4] 2> 3484734 INFO (jetty-launcher-25018-thread-3) [ ] o.e.j.s.Server Started @3484771ms [junit4] 2> 3484734 INFO (jetty-launcher-25018-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=56025} [junit4] 2> 3484734 ERROR (jetty-launcher-25018-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 3484734 INFO (jetty-launcher-25018-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 3484734 INFO (jetty-launcher-25018-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0 [junit4] 2> 3484734 INFO (jetty-launcher-25018-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 3484734 INFO (jetty-launcher-25018-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 3484734 INFO (jetty-launcher-25018-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-05-31T18:46:30.446616300Z [junit4] 2> 3484752 INFO (zkConnectionManagerCallback-25020-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 3484752 INFO (jetty-launcher-25018-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 3484758 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x100566dda560003, likely client has closed socket [junit4] 2> 3484847 INFO (zkConnectionManagerCallback-25022-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 3484849 INFO (jetty-launcher-25018-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 3485047 INFO (zkConnectionManagerCallback-25024-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 3485047 INFO (jetty-launcher-25018-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 3485053 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x100566dda560005, likely client has closed socket [junit4] 2> 3485119 INFO (jetty-launcher-25018-thread-3) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 3485325 INFO (jetty-launcher-25018-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 3485412 WARN (jetty-launcher-25018-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@2beedc41[provider=null,keyStore=null,trustStore=null] [junit4] 2> 3485437 INFO (jetty-launcher-25018-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 3485439 WARN (jetty-launcher-25018-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@32893cf3[provider=null,keyStore=null,trustStore=null] [junit4] 2> 3485447 WARN (jetty-launcher-25018-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@2decb470[provider=null,keyStore=null,trustStore=null] [junit4] 2> 3485448 INFO (jetty-launcher-25018-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56004/solr [junit4] 2> 3485450 WARN (jetty-launcher-25018-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@56ec93c[provider=null,keyStore=null,trustStore=null] [junit4] 2> 3485455 WARN (jetty-launcher-25018-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@44920518[provider=null,keyStore=null,trustStore=null] [junit4] 2> 3485457 INFO (jetty-launcher-25018-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56004/solr [junit4] 2> 3485459 WARN (jetty-launcher-25018-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@7b908854[provider=null,keyStore=null,trustStore=null] [junit4] 2> 3485463 INFO (jetty-launcher-25018-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56004/solr [junit4] 2> 3485471 INFO (zkConnectionManagerCallback-25037-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 3485473 INFO (zkConnectionManagerCallback-25042-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 3485477 INFO (zkConnectionManagerCallback-25045-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 3485479 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x100566dda560008, likely client has closed socket [junit4] 2> 3485484 INFO (zkConnectionManagerCallback-25047-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 3485485 INFO (zkConnectionManagerCallback-25049-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 3485489 INFO (zkConnectionManagerCallback-25051-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 3485685 INFO (jetty-launcher-25018-thread-3) [n:127.0.0.1:56025_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:56025_solr [junit4] 2> 3485687 INFO (jetty-launcher-25018-thread-3) [n:127.0.0.1:56025_solr ] o.a.s.c.Overseer Overseer (id=72152623852421129-127.0.0.1:56025_solr-n_0000000000) starting [junit4] 2> 3485720 INFO (jetty-launcher-25018-thread-2) [n:127.0.0.1:56022_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:56022_solr [junit4] 2> 3485724 INFO (jetty-launcher-25018-thread-1) [n:127.0.0.1:56019_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:56019_solr as DOWN [junit4] 2> 3485725 INFO (jetty-launcher-25018-thread-1) [n:127.0.0.1:56019_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 3485725 INFO (jetty-launcher-25018-thread-1) [n:127.0.0.1:56019_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:56019_solr [junit4] 2> 3485727 INFO (zkCallback-25048-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 3485728 INFO (zkCallback-25046-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 3485728 INFO (zkCallback-25050-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 3485728 INFO (zkConnectionManagerCallback-25062-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 3485730 INFO (jetty-launcher-25018-thread-3) [n:127.0.0.1:56025_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 3485732 INFO (jetty-launcher-25018-thread-3) [n:127.0.0.1:56025_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:56004/solr ready [junit4] 2> 3485734 INFO (jetty-launcher-25018-thread-3) [n:127.0.0.1:56025_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:56025_solr as DOWN [junit4] 2> 3485735 INFO (jetty-launcher-25018-thread-3) [n:127.0.0.1:56025_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 3485735 INFO (jetty-launcher-25018-thread-3) [n:127.0.0.1:56025_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:56025_solr [junit4] 2> 3485737 INFO (zkCallback-25048-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 3485737 INFO (zkCallback-25050-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 3485737 INFO (zkCallback-25046-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 3485739 INFO (OverseerStateUpdate-72152623852421129-127.0.0.1:56025_solr-n_0000000000) [n:127.0.0.1:56025_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:56025_solr [junit4] 2> 3485748 INFO (zkConnectionManagerCallback-25067-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 3485752 INFO (zkCallback-25061-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 3485752 INFO (jetty-launcher-25018-thread-2) [n:127.0.0.1:56022_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 3485754 INFO (jetty-launcher-25018-thread-2) [n:127.0.0.1:56022_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:56004/solr ready [junit4] 2> 3485783 INFO (jetty-launcher-25018-thread-3) [n:127.0.0.1:56025_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 3485793 INFO (jetty-launcher-25018-thread-2) [n:127.0.0.1:56022_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 3485809 INFO (zkConnectionManagerCallback-25072-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 3485823 INFO (jetty-launcher-25018-thread-1) [n:127.0.0.1:56019_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 3485830 INFO (jetty-launcher-25018-thread-1) [n:127.0.0.1:56019_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:56004/solr ready [junit4] 2> 3485835 INFO (jetty-launcher-25018-thread-3) [n:127.0.0.1:56025_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56025.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25c4cfd9 [junit4] 2> 3485841 INFO (jetty-launcher-25018-thread-2) [n:127.0.0.1:56022_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56022.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25c4cfd9 [junit4] 2> 3485863 INFO (jetty-launcher-25018-thread-3) [n:127.0.0.1:56025_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56025.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25c4cfd9 [junit4] 2> 3485864 INFO (jetty-launcher-25018-thread-3) [n:127.0.0.1:56025_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56025.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25c4cfd9 [junit4] 2> 3485867 INFO (jetty-launcher-25018-thread-3) [n:127.0.0.1:56025_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_54734BA451F87FA9-001\tempDir-001\node3\. [junit4] 2> 3485868 INFO (jetty-launcher-25018-thread-1) [n:127.0.0.1:56019_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 3485868 INFO (jetty-launcher-25018-thread-2) [n:127.0.0.1:56022_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56022.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25c4cfd9 [junit4] 2> 3485869 INFO (jetty-launcher-25018-thread-2) [n:127.0.0.1:56022_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56022.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25c4cfd9 [junit4] 2> 3485871 INFO (jetty-launcher-25018-thread-2) [n:127.0.0.1:56022_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_54734BA451F87FA9-001\tempDir-001\node2\. [junit4] 2> 3485900 INFO (jetty-launcher-25018-thread-1) [n:127.0.0.1:56019_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56019.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25c4cfd9 [junit4] 2> 3485913 INFO (jetty-launcher-25018-thread-1) [n:127.0.0.1:56019_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56019.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25c4cfd9 [junit4] 2> 3485913 INFO (jetty-launcher-25018-thread-1) [n:127.0.0.1:56019_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56019.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25c4cfd9 [junit4] 2> 3485915 INFO (jetty-launcher-25018-thread-1) [n:127.0.0.1:56019_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_54734BA451F87FA9-001\tempDir-001\node1\. [junit4] 2> 3486020 INFO (zkConnectionManagerCallback-25080-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 3486023 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 3486024 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:56004/solr ready [junit4] 2> 3486033 INFO (qtp1281134183-60903) [n:127.0.0.1:56025_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=conf&name=authCollection&nrtReplicas=1&action=CREATE&numShards=3&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 3486040 INFO (OverseerThreadFactory-18319-thread-1-processing-n:127.0.0.1:56025_solr) [n:127.0.0.1:56025_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection authCollection [junit4] 2> 3486167 INFO (OverseerStateUpdate-72152623852421129-127.0.0.1:56025_solr-n_0000000000) [n:127.0.0.1:56025_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"authCollection", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"authCollection_shard1_replica_n1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:56019/solr";, [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 3486169 INFO (OverseerStateUpdate-72152623852421129-127.0.0.1:56025_solr-n_0000000000) [n:127.0.0.1:56025_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"authCollection", [junit4] 2> "shard":"shard2", [junit4] 2> "core":"authCollection_shard2_replica_n2", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:56022/solr";, [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 3486170 INFO (OverseerStateUpdate-72152623852421129-127.0.0.1:56025_solr-n_0000000000) [n:127.0.0.1:56025_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"authCollection", [junit4] 2> "shard":"shard3", [junit4] 2> "core":"authCollection_shard3_replica_n3", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:56025/solr";, [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 3486399 INFO (qtp1462715953-60886) [n:127.0.0.1:56019_solr x:authCollection_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=authCollection_shard1_replica_n1&action=CREATE&numShards=3&collection=authCollection&shard=shard1&wt=javabin&version=2&replicaType=NRT [junit4] 2> 3486399 INFO (qtp355843513-60895) [n:127.0.0.1:56022_solr x:authCollection_shard2_replica_n2] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=authCollection_shard2_replica_n2&action=CREATE&numShards=3&collection=authCollection&shard=shard2&wt=javabin&version=2&replicaType=NRT [junit4] 2> 3486399 INFO (qtp355843513-60895) [n:127.0.0.1:56022_solr x:authCollection_shard2_replica_n2] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 3486414 INFO (qtp1281134183-60906) [n:127.0.0.1:56025_solr x:authCollection_shard3_replica_n3] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node6&collection.configName=conf&newCollection=true&name=authCollection_shard3_replica_n3&action=CREATE&numShards=3&collection=authCollection&shard=shard3&wt=javabin&version=2&replicaType=NRT [junit4] 2> 3487424 INFO (qtp1462715953-60886) [n:127.0.0.1:56019_solr c:authCollection s:shard1 r:core_node4 x:authCollection_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0 [junit4] 2> 3487424 INFO (qtp355843513-60895) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0 [junit4] 2> 3487452 INFO (qtp1462715953-60886) [n:127.0.0.1:56019_solr c:authCollection s:shard1 r:core_node4 x:authCollection_shard1_replica_n1] o.a.s.s.IndexSchema [authCollection_shard1_replica_n1] Schema name=minimal [junit4] 2> 3487453 INFO (qtp355843513-60895) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.s.IndexSchema [authCollection_shard2_replica_n2] Schema name=minimal [junit4] 2> 3487455 INFO (qtp355843513-60895) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 3487455 INFO (qtp355843513-60895) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.c.CoreContainer Creating SolrCore 'authCollection_shard2_replica_n2' using configuration from collection authCollection, trusted=true [junit4] 2> 3487455 INFO (qtp1462715953-60886) [n:127.0.0.1:56019_solr c:authCollection s:shard1 r:core_node4 x:authCollection_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 3487455 INFO (qtp1462715953-60886) [n:127.0.0.1:56019_solr c:authCollection s:shard1 r:core_node4 x:authCollection_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'authCollection_shard1_replica_n1' using configuration from collection authCollection, trusted=true [junit4] 2> 3487456 INFO (qtp355843513-60895) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56022.solr.core.authCollection.shard2.replica_n2' (registry 'solr.core.authCollection.shard2.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25c4cfd9 [junit4] 2> 3487456 INFO (qtp355843513-60895) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.c.SolrCore [[authCollection_shard2_replica_n2] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_54734BA451F87FA9-001\tempDir-001\node2\authCollection_shard2_replica_n2], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_54734BA451F87FA9-001\tempDir-001\node2\.\authCollection_shard2_replica_n2\data\] [junit4] 2> 3487456 INFO (qtp1462715953-60886) [n:127.0.0.1:56019_solr c:authCollection s:shard1 r:core_node4 x:authCollection_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56019.solr.core.authCollection.shard1.replica_n1' (registry 'solr.core.authCollection.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25c4cfd9 [junit4] 2> 3487456 INFO (qtp1462715953-60886) [n:127.0.0.1:56019_solr c:authCollection s:shard1 r:core_node4 x:authCollection_shard1_replica_n1] o.a.s.c.SolrCore [[authCollection_shard1_replica_n1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_54734BA451F87FA9-001\tempDir-001\node1\authCollection_shard1_replica_n1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_54734BA451F87FA9-001\tempDir-001\node1\.\authCollection_shard1_replica_n1\data\] [junit4] 2> 3487468 INFO (qtp1281134183-60906) [n:127.0.0.1:56025_solr c:authCollection s:shard3 r:core_node6 x:authCollection_shard3_replica_n3] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0 [junit4] 2> 3487478 INFO (qtp1281134183-60906) [n:127.0.0.1:56025_solr c:authCollection s:shard3 r:core_node6 x:authCollection_shard3_replica_n3] o.a.s.s.IndexSchema [authCollection_shard3_replica_n3] Schema name=minimal [junit4] 2> 3487480 INFO (qtp1281134183-60906) [n:127.0.0.1:56025_solr c:authCollection s:shard3 r:core_node6 x:authCollection_shard3_replica_n3] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 3487480 INFO (qtp1281134183-60906) [n:127.0.0.1:56025_solr c:authCollection s:shard3 r:core_node6 x:authCollection_shard3_replica_n3] o.a.s.c.CoreContainer Creating SolrCore 'authCollection_shard3_replica_n3' using configuration from collection authCollection, trusted=true [junit4] 2> 3487480 INFO (qtp1281134183-60906) [n:127.0.0.1:56025_solr c:authCollection s:shard3 r:core_node6 x:authCollection_shard3_replica_n3] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56025.solr.core.authCollection.shard3.replica_n3' (registry 'solr.core.authCollection.shard3.replica_n3') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25c4cfd9 [junit4] 2> 3487481 INFO (qtp1281134183-60906) [n:127.0.0.1:56025_solr c:authCollection s:shard3 r:core_node6 x:authCollection_shard3_replica_n3] o.a.s.c.SolrCore [[authCollection_shard3_replica_n3] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_54734BA451F87FA9-001\tempDir-001\node3\authCollection_shard3_replica_n3], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_54734BA451F87FA9-001\tempDir-001\node3\.\authCollection_shard3_replica_n3\data\] [junit4] 2> 3487647 INFO (qtp1462715953-60886) [n:127.0.0.1:56019_solr c:authCollection s:shard1 r:core_node4 x:authCollection_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 3487647 INFO (qtp1462715953-60886) [n:127.0.0.1:56019_solr c:authCollection s:shard1 r:core_node4 x:authCollection_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 3487647 INFO (qtp355843513-60895) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 3487647 INFO (qtp355843513-60895) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 3487650 INFO (qtp1462715953-60886) [n:127.0.0.1:56019_solr c:authCollection s:shard1 r:core_node4 x:authCollection_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 3487650 INFO (qtp1462715953-60886) [n:127.0.0.1:56019_solr c:authCollection s:shard1 r:core_node4 x:authCollection_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 3487650 INFO (qtp355843513-60895) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 3487650 INFO (qtp355843513-60895) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 3487681 INFO (qtp355843513-60895) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.s.SolrIndexSearcher Opening [Searcher@8045bac[authCollection_shard2_replica_n2] main] [junit4] 2> 3487689 INFO (qtp1281134183-60906) [n:127.0.0.1:56025_solr c:authCollection s:shard3 r:core_node6 x:authCollection_shard3_replica_n3] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 3487689 INFO (qtp1281134183-60906) [n:127.0.0.1:56025_solr c:authCollection s:shard3 r:core_node6 x:authCollection_shard3_replica_n3] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 3487693 INFO (qtp1281134183-60906) [n:127.0.0.1:56025_solr c:authCollection s:shard3 r:core_node6 x:authCollection_shard3_replica_n3] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 3487693 INFO (qtp1281134183-60906) [n:127.0.0.1:56025_solr c:authCollection s:shard3 r:core_node6 x:authCollection_shard3_replica_n3] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 3487681 INFO (qtp1462715953-60886) [n:127.0.0.1:56019_solr c:authCollection s:shard1 r:core_node4 x:authCollection_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5669159a[authCollection_shard1_replica_n1] main] [junit4] 2> 3487695 INFO (qtp355843513-60895) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 3487695 INFO (qtp355843513-60895) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf [junit4] 2> 3487695 INFO (qtp355843513-60895) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 3487695 INFO (qtp355843513-60895) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1635074329445138432 [junit4] 2> 3487696 INFO (qtp1462715953-60886) [n:127.0.0.1:56019_solr c:authCollection s:shard1 r:core_node4 x:authCollection_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 3487697 INFO (qtp1462715953-60886) [n:127.0.0.1:56019_solr c:authCollection s:shard1 r:core_node4 x:authCollection_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf [junit4] 2> 3487699 INFO (searcherExecutor-18332-thread-1-processing-n:127.0.0.1:56022_solr x:authCollection_shard2_replica_n2 c:authCollection s:shard2 r:core_node5) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.c.SolrCore [authCollection_shard2_replica_n2] Registered new searcher Searcher@8045bac[authCollection_shard2_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 3487700 INFO (qtp1462715953-60886) [n:127.0.0.1:56019_solr c:authCollection s:shard1 r:core_node4 x:authCollection_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 3487700 INFO (qtp355843513-60895) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.c.ZkShardTerms Successful update of terms at /collections/authCollection/terms/shard2 to Terms{values={core_node5=0}, version=0} [junit4] 2> 3487700 INFO (qtp355843513-60895) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/authCollection/leaders/shard2 [junit4] 2> 3487703 INFO (qtp1462715953-60886) [n:127.0.0.1:56019_solr c:authCollection s:shard1 r:core_node4 x:authCollection_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1635074329453527040 [junit4] 2> 3487706 INFO (qtp355843513-60895) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 3487706 INFO (qtp355843513-60895) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 3487706 INFO (qtp355843513-60895) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:56022/solr/authCollection_shard2_replica_n2/ [junit4] 2> 3487706 INFO (qtp355843513-60895) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 3487706 INFO (qtp355843513-60895) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.c.SyncStrategy http://127.0.0.1:56022/solr/authCollection_shard2_replica_n2/ has no replicas [junit4] 2> 3487706 INFO (qtp355843513-60895) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/authCollection/leaders/shard2/leader after winning as /collections/authCollection/leader_elect/shard2/election/72152623852421131-core_node5-n_0000000000 [junit4] 2> 3487708 INFO (qtp355843513-60895) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:56022/solr/authCollection_shard2_replica_n2/ shard2 [junit4] 2> 3487708 INFO (searcherExecutor-18333-thread-1-processing-n:127.0.0.1:56019_solr x:authCollection_shard1_replica_n1 c:authCollection s:shard1 r:core_node4) [n:127.0.0.1:56019_solr c:authCollection s:shard1 r:core_node4 x:authCollection_shard1_replica_n1] o.a.s.c.SolrCore [authCollection_shard1_replica_n1] Registered new searcher Searcher@5669159a[authCollection_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 3487712 INFO (qtp1281134183-60906) [n:127.0.0.1:56025_solr c:authCollection s:shard3 r:core_node6 x:authCollection_shard3_replica_n3] o.a.s.s.SolrIndexSearcher Opening [Searcher@3a9d3e17[authCollection_shard3_replica_n3] main] [junit4] 2> 3487715 INFO (qtp1281134183-60906) [n:127.0.0.1:56025_solr c:authCollection s:shard3 r:core_node6 x:authCollection_shard3_replica_n3] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 3487715 INFO (qtp1462715953-60886) [n:127.0.0.1:56019_solr c:authCollection s:shard1 r:core_node4 x:authCollection_shard1_replica_n1] o.a.s.c.ZkShardTerms Successful update of terms at /collections/authCollection/terms/shard1 to Terms{values={core_node4=0}, version=0} [junit4] 2> 3487716 INFO (qtp1462715953-60886) [n:127.0.0.1:56019_solr c:authCollection s:shard1 r:core_node4 x:authCollection_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/authCollection/leaders/shard1 [junit4] 2> 3487716 INFO (qtp1281134183-60906) [n:127.0.0.1:56025_solr c:authCollection s:shard3 r:core_node6 x:authCollection_shard3_replica_n3] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf [junit4] 2> 3487716 INFO (qtp1281134183-60906) [n:127.0.0.1:56025_solr c:authCollection s:shard3 r:core_node6 x:authCollection_shard3_replica_n3] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 3487716 INFO (qtp1281134183-60906) [n:127.0.0.1:56025_solr c:authCollection s:shard3 r:core_node6 x:authCollection_shard3_replica_n3] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1635074329467158528 [junit4] 2> 3487720 INFO (searcherExecutor-18334-thread-1-processing-n:127.0.0.1:56025_solr x:authCollection_shard3_replica_n3 c:authCollection s:shard3 r:core_node6) [n:127.0.0.1:56025_solr c:authCollection s:shard3 r:core_node6 x:authCollection_shard3_replica_n3] o.a.s.c.SolrCore [authCollection_shard3_replica_n3] Registered new searcher Searcher@3a9d3e17[authCollection_shard3_replica_n3] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 3487723 INFO (qtp1462715953-60886) [n:127.0.0.1:56019_solr c:authCollection s:shard1 r:core_node4 x:authCollection_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 3487723 INFO (qtp1462715953-60886) [n:127.0.0.1:56019_solr c:authCollection s:shard1 r:core_node4 x:authCollection_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 3487723 INFO (qtp1462715953-60886) [n:127.0.0.1:56019_solr c:authCollection s:shard1 r:core_node4 x:authCollection_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:56019/solr/authCollection_shard1_replica_n1/ [junit4] 2> 3487724 INFO (qtp1462715953-60886) [n:127.0.0.1:56019_solr c:authCollection s:shard1 r:core_node4 x:authCollection_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 3487724 INFO (qtp1462715953-60886) [n:127.0.0.1:56019_solr c:authCollection s:shard1 r:core_node4 x:authCollection_shard1_replica_n1] o.a.s.c.SyncStrategy http://127.0.0.1:56019/solr/authCollection_shard1_replica_n1/ has no replicas [junit4] 2> 3487724 INFO (qtp1462715953-60886) [n:127.0.0.1:56019_solr c:authCollection s:shard1 r:core_node4 x:authCollection_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/authCollection/leaders/shard1/leader after winning as /collections/authCollection/leader_elect/shard1/election/72152623852421130-core_node4-n_0000000000 [junit4] 2> 3487725 INFO (qtp1281134183-60906) [n:127.0.0.1:56025_solr c:authCollection s:shard3 r:core_node6 x:authCollection_shard3_replica_n3] o.a.s.c.ZkShardTerms Successful update of terms at /collections/authCollection/terms/shard3 to Terms{values={core_node6=0}, version=0} [junit4] 2> 3487725 INFO (qtp1281134183-60906) [n:127.0.0.1:56025_solr c:authCollection s:shard3 r:core_node6 x:authCollection_shard3_replica_n3] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/authCollection/leaders/shard3 [junit4] 2> 3487726 INFO (qtp1462715953-60886) [n:127.0.0.1:56019_solr c:authCollection s:shard1 r:core_node4 x:authCollection_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:56019/solr/authCollection_shard1_replica_n1/ shard1 [junit4] 2> 3487730 INFO (qtp1281134183-60906) [n:127.0.0.1:56025_solr c:authCollection s:shard3 r:core_node6 x:authCollection_shard3_replica_n3] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 3487730 INFO (qtp1281134183-60906) [n:127.0.0.1:56025_solr c:authCollection s:shard3 r:core_node6 x:authCollection_shard3_replica_n3] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 3487730 INFO (qtp1281134183-60906) [n:127.0.0.1:56025_solr c:authCollection s:shard3 r:core_node6 x:authCollection_shard3_replica_n3] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:56025/solr/authCollection_shard3_replica_n3/ [junit4] 2> 3487730 INFO (qtp1281134183-60906) [n:127.0.0.1:56025_solr c:authCollection s:shard3 r:core_node6 x:authCollection_shard3_replica_n3] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 3487731 INFO (qtp1281134183-60906) [n:127.0.0.1:56025_solr c:authCollection s:shard3 r:core_node6 x:authCollection_shard3_replica_n3] o.a.s.c.SyncStrategy http://127.0.0.1:56025/solr/authCollection_shard3_replica_n3/ has no replicas [junit4] 2> 3487731 INFO (qtp1281134183-60906) [n:127.0.0.1:56025_solr c:authCollection s:shard3 r:core_node6 x:authCollection_shard3_replica_n3] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/authCollection/leaders/shard3/leader after winning as /collections/authCollection/leader_elect/shard3/election/72152623852421129-core_node6-n_0000000000 [junit4] 2> 3487733 INFO (qtp1281134183-60906) [n:127.0.0.1:56025_solr c:authCollection s:shard3 r:core_node6 x:authCollection_shard3_replica_n3] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:56025/solr/authCollection_shard3_replica_n3/ shard3 [junit4] 2> 3487836 INFO (zkCallback-25046-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 3487836 INFO (zkCallback-25048-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 3487836 INFO (zkCallback-25050-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 3487838 INFO (qtp1281134183-60906) [n:127.0.0.1:56025_solr c:authCollection s:shard3 r:core_node6 x:authCollection_shard3_replica_n3] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 3487838 INFO (qtp355843513-60895) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 3487838 INFO (qtp1462715953-60886) [n:127.0.0.1:56019_solr c:authCollection s:shard1 r:core_node4 x:authCollection_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 3487841 INFO (qtp355843513-60895) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=authCollection_shard2_replica_n2&action=CREATE&numShards=3&collection=authCollection&shard=shard2&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1442 [junit4] 2> 3487842 INFO (qtp1462715953-60886) [n:127.0.0.1:56019_solr c:authCollection s:shard1 r:core_node4 x:authCollection_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=authCollection_shard1_replica_n1&action=CREATE&numShards=3&collection=authCollection&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1443 [junit4] 2> 3487843 INFO (qtp1281134183-60906) [n:127.0.0.1:56025_solr c:authCollection s:shard3 r:core_node6 x:authCollection_shard3_replica_n3] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node6&collection.configName=conf&newCollection=true&name=authCollection_shard3_replica_n3&action=CREATE&numShards=3&collection=authCollection&shard=shard3&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1429 [junit4] 2> 3487843 INFO (zkCallback-25046-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 3487844 INFO (zkCallback-25048-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 3487846 INFO (zkCallback-25050-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 3487848 INFO (qtp1281134183-60903) [n:127.0.0.1:56025_solr ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas [junit4] 2> 3487950 INFO (zkCallback-25046-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 3487950 INFO (zkCallback-25046-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 3487950 INFO (zkCallback-25046-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 3487950 INFO (zkCallback-25048-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 3487951 INFO (zkCallback-25048-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 3487951 INFO (zkCallback-25050-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 3487951 INFO (zkCallback-25050-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 3487952 INFO (qtp1281134183-60903) [n:127.0.0.1:56025_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=conf&name=authCollection&nrtReplicas=1&action=CREATE&numShards=3&wt=javabin&version=2} status=0 QTime=1919 [junit4] 2> 3487954 INFO (zkCallback-25048-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 3487955 INFO (zkCallback-25050-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 3487956 INFO (qtp355843513-60897) [n:127.0.0.1:56022_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/authentication params={} status=0 QTime=0 [junit4] 2> 3487957 INFO (qtp355843513-60898) [n:127.0.0.1:56022_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/authentication params={} status=0 QTime=0 [junit4] 2> 3487958 INFO (zkCallback-25046-thread-1) [ ] o.a.s.c.CoreContainer Security node changed, reloading security.json [junit4] 2> 3487958 INFO (zkCallback-25046-thread-1) [ ] o.a.s.c.CoreContainer Initializing authorization plugin: solr.RuleBasedAuthorizationPlugin [junit4] 2> 3487958 INFO (zkCallback-25046-thread-1) [ ] o.a.s.c.CoreContainer Initializing authentication plugin: solr.BasicAuthPlugin [junit4] 2> 3487959 INFO (zkCallback-25048-thread-3) [ ] o.a.s.c.CoreContainer Security node changed, reloading security.json [junit4] 2> 3487959 INFO (zkCallback-25048-thread-3) [ ] o.a.s.c.CoreContainer Initializing authorization plugin: solr.RuleBasedAuthorizationPlugin [junit4] 2> 3487959 INFO (zkCallback-25048-thread-3) [ ] o.a.s.c.CoreContainer Initializing authentication plugin: solr.BasicAuthPlugin [junit4] 2> 3487959 INFO (zkCallback-25050-thread-3) [ ] o.a.s.c.CoreContainer Security node changed, reloading security.json [junit4] 2> 3487959 INFO (zkCallback-25050-thread-3) [ ] o.a.s.c.CoreContainer Initializing authorization plugin: solr.RuleBasedAuthorizationPlugin [junit4] 2> 3487959 INFO (zkCallback-25050-thread-3) [ ] o.a.s.c.CoreContainer Initializing authentication plugin: solr.BasicAuthPlugin [junit4] 2> 3488009 INFO (qtp355843513-60899) [n:127.0.0.1:56022_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/authentication params={} status=0 QTime=0 [junit4] 2> 3488010 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1011594731 [junit4] 2> 3488010 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:56022_solr [junit4] 2> 3488011 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.c.ZkController Publish this node as DOWN... [junit4] 2> 3488011 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:56022_solr as DOWN [junit4] 2> 3488014 INFO (coreCloseExecutor-18347-thread-1) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.c.SolrCore [authCollection_shard2_replica_n2] CLOSING SolrCore org.apache.solr.core.SolrCore@4968e7cc [junit4] 2> 3488014 INFO (coreCloseExecutor-18347-thread-1) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.authCollection.shard2.replica_n2, tag=4968e7cc [junit4] 2> 3488014 INFO (coreCloseExecutor-18347-thread-1) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3965c985: rootName = solr_56022, domain = solr.core.authCollection.shard2.replica_n2, service url = null, agent id = null] for registry solr.core.authCollection.shard2.replica_n2 / com.codahale.metrics.MetricRegistry@764e943 [junit4] 2> 3488018 INFO (coreCloseExecutor-18347-thread-1) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.authCollection.shard2.leader, tag=4968e7cc [junit4] 2> 3488023 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 3488023 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2d9e8187: rootName = solr_56022, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@673893f5 [junit4] 2> 3488027 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 3488027 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@476f9609: rootName = solr_56022, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@3ce98029 [junit4] 2> 3488034 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 3488034 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2bc9b4d3: rootName = solr_56022, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@45ac1db5 [junit4] 2> 3488034 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 3488037 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x100566dda56000b, likely client has closed socket [junit4] 2> 3488037 INFO (zkCallback-25048-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2) [junit4] 2> 3488038 INFO (zkCallback-25046-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2) [junit4] 2> 3488038 INFO (zkCallback-25061-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2) [junit4] 2> 3488038 INFO (zkCallback-25071-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2) [junit4] 2> 3488038 INFO (zkCallback-25066-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2) [junit4] 2> 3488039 INFO (zkCallback-25079-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2) [junit4] 2> 3488041 INFO (OverseerCollectionConfigSetProcessor-72152623852421129-127.0.0.1:56025_solr-n_0000000000) [n:127.0.0.1:56025_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 3488044 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@77205b08{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0} [junit4] 2> 3488045 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2fd3f28a{/solr,null,UNAVAILABLE} [junit4] 2> 3488046 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> 3488047 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 3488047 WARN (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 3488047 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 56022 try number 1 ... [junit4] 2> 3488047 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 13-ea+18 [junit4] 2> 3488048 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 3488048 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 3488048 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 3488048 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6bdb1bb8{/solr,null,AVAILABLE} [junit4] 2> 3488049 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@7cd29df1{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:56022} [junit4] 2> 3488049 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.e.j.s.Server Started @3488086ms [junit4] 2> 3488049 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=56022} [junit4] 2> 3488049 ERROR (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 3488049 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 3488049 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0 [junit4] 2> 3488049 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 3488049 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 3488049 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-05-31T18:46:33.761684700Z [junit4] 2> 3488054 INFO (zkConnectionManagerCallback-25089-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 3488056 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 3488062 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x100566dda560010, likely client has closed socket [junit4] 2> 3488117 INFO (zkCallback-25046-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [2]) [junit4] 2> 3488118 INFO (zkCallback-25046-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [2]) [junit4] 2> 3488118 INFO (zkCallback-25046-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [2]) [junit4] 2> 3488119 INFO (zkCallback-25048-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [2]) [junit4] 2> 3488119 INFO (zkCallback-25048-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [2]) [junit4] 2> 3488119 INFO (zkCallback-25048-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [2]) [junit4] 2> 3488157 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 3488160 WARN (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@7780c505[provider=null,keyStore=null,trustStore=null] [junit4] 2> 3488164 WARN (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@f58b18a[provider=null,keyStore=null,trustStore=null] [junit4] 2> 3488164 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56004/solr [junit4] 2> 3488169 INFO (zkConnectionManagerCallback-25096-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 3488170 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x100566dda560011, likely client has closed socket [junit4] 2> 3488174 INFO (zkConnectionManagerCallback-25098-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 3488181 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [n:127.0.0.1:56022_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 3488185 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [n:127.0.0.1:56022_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:56022_solr as DOWN [junit4] 2> 3488186 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [n:127.0.0.1:56022_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 3488186 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [n:127.0.0.1:56022_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:56022_solr [junit4] 2> 3488188 INFO (zkCallback-25071-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 3488188 INFO (zkCallback-25046-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 3488188 INFO (zkCallback-25048-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 3488188 INFO (zkCallback-25061-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 3488189 INFO (zkCallback-25079-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 3488189 INFO (zkCallback-25097-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 3488193 INFO (zkConnectionManagerCallback-25105-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 3488196 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [n:127.0.0.1:56022_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 3488196 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [n:127.0.0.1:56022_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:56004/solr ready [junit4] 2> 3488197 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [n:127.0.0.1:56022_solr ] o.a.s.c.CoreContainer Initializing authorization plugin: solr.RuleBasedAuthorizationPlugin [junit4] 2> 3488198 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [n:127.0.0.1:56022_solr ] o.a.s.c.CoreContainer Initializing authentication plugin: solr.BasicAuthPlugin [junit4] 2> 3488235 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [n:127.0.0.1:56022_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 3488264 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [n:127.0.0.1:56022_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56022.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25c4cfd9 [junit4] 2> 3488284 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [n:127.0.0.1:56022_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56022.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25c4cfd9 [junit4] 2> 3488284 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [n:127.0.0.1:56022_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56022.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25c4cfd9 [junit4] 2> 3488289 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [n:127.0.0.1:56022_solr ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_54734BA451F87FA9-001\tempDir-001\node2\. [junit4] 2> 3488289 INFO (TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[54734BA451F87FA9]) [n:127.0.0.1:56022_solr ] o.a.s.c.CorePropertiesLocator Cores are: [authCollection_shard2_replica_n2] [junit4] 2> 3488293 INFO (zkCallback-25046-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 3488293 INFO (zkCallback-25046-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 3488293 INFO (zkCallback-25046-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 3488293 INFO (zkCallback-25048-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 3488293 INFO (zkCallback-25048-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 3488293 INFO (zkCallback-25048-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/authCollection/state.json] for collection [authCollection] has occurred - updating... (live nodes size: [3]) [junit4] 2> 3488310 INFO (coreLoadExecutor-18357-thread-1-processing-n:127.0.0.1:56022_solr) [n:127.0.0.1:56022_solr ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0 [junit4] 2> 3488393 INFO (coreLoadExecutor-18357-thread-1-processing-n:127.0.0.1:56022_solr) [n:127.0.0.1:56022_solr ] o.a.s.s.IndexSchema [authCollection_shard2_replica_n2] Schema name=minimal [junit4] 2> 3488395 INFO (coreLoadExecutor-18357-thread-1-processing-n:127.0.0.1:56022_solr) [n:127.0.0.1:56022_solr ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 3488410 INFO (coreLoadExecutor-18357-thread-1-processing-n:127.0.0.1:56022_solr) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0 [junit4] 2> 3488420 INFO (coreLoadExecutor-18357-thread-1-processing-n:127.0.0.1:56022_solr) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.s.IndexSchema [authCollection_shard2_replica_n2] Schema name=minimal [junit4] 2> 3488423 INFO (coreLoadExecutor-18357-thread-1-processing-n:127.0.0.1:56022_solr) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 3488423 INFO (coreLoadExecutor-18357-thread-1-processing-n:127.0.0.1:56022_solr) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.c.CoreContainer Creating SolrCore 'authCollection_shard2_replica_n2' using configuration from collection authCollection, trusted=true [junit4] 2> 3488424 INFO (coreLoadExecutor-18357-thread-1-processing-n:127.0.0.1:56022_solr) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56022.solr.core.authCollection.shard2.replica_n2' (registry 'solr.core.authCollection.shard2.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25c4cfd9 [junit4] 2> 3488424 INFO (coreLoadExecutor-18357-thread-1-processing-n:127.0.0.1:56022_solr) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.c.SolrCore [[authCollection_shard2_replica_n2] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_54734BA451F87FA9-001\tempDir-001\node2\authCollection_shard2_replica_n2], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_54734BA451F87FA9-001\tempDir-001\node2\.\authCollection_shard2_replica_n2\data\] [junit4] 2> 3488775 INFO (coreLoadExecutor-18357-thread-1-processing-n:127.0.0.1:56022_solr) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 3488775 INFO (coreLoadExecutor-18357-thread-1-processing-n:127.0.0.1:56022_solr) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 3488777 INFO (coreLoadExecutor-18357-thread-1-processing-n:127.0.0.1:56022_solr) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 3488777 INFO (coreLoadExecutor-18357-thread-1-processing-n:127.0.0.1:56022_solr) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 3488783 INFO (coreLoadExecutor-18357-thread-1-processing-n:127.0.0.1:56022_solr) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.s.SolrIndexSearcher Opening [Searcher@33b5d19b[authCollection_shard2_replica_n2] main] [junit4] 2> 3488785 INFO (coreLoadExecutor-18357-thread-1-processing-n:127.0.0.1:56022_solr) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 3488785 INFO (coreLoadExecutor-18357-thread-1-processing-n:127.0.0.1:56022_solr) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf [junit4] 2> 3488785 INFO (coreLoadExecutor-18357-thread-1-processing-n:127.0.0.1:56022_solr) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 3488785 INFO (coreLoadExecutor-18357-thread-1-processing-n:127.0.0.1:56022_solr) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1635074330588086272 [junit4] 2> 3488789 INFO (searcherExecutor-18358-thread-1-processing-n:127.0.0.1:56022_solr x:authCollection_shard2_replica_n2 c:authCollection s:shard2 r:core_node5) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.c.SolrCore [authCollection_shard2_replica_n2] Registered new searcher Searcher@33b5d19b[authCollection_shard2_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 3488794 INFO (coreZkRegister-18349-thread-1-processing-n:127.0.0.1:56022_solr x:authCollection_shard2_replica_n2 c:authCollection s:shard2 r:core_node5) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/authCollection/leaders/shard2 [junit4] 2> 3488797 INFO (coreZkRegister-18349-thread-1-processing-n:127.0.0.1:56022_solr x:authCollection_shard2_replica_n2 c:authCollection s:shard2 r:core_node5) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 3488797 INFO (coreZkRegister-18349-thread-1-processing-n:127.0.0.1:56022_solr x:authCollection_shard2_replica_n2 c:authCollection s:shard2 r:core_node5) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 3488797 INFO (coreZkRegister-18349-thread-1-processing-n:127.0.0.1:56022_solr x:authCollection_shard2_replica_n2 c:authCollection s:shard2 r:core_node5) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:56022/solr/authCollection_shard2_replica_n2/ [junit4] 2> 3488797 INFO (coreZkRegister-18349-thread-1-processing-n:127.0.0.1:56022_solr x:authCollection_shard2_replica_n2 c:authCollection s:shard2 r:core_node5) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 3488797 INFO (coreZkRegister-18349-thread-1-processing-n:127.0.0.1:56022_solr x:authCollection_shard2_replica_n2 c:authCollection s:shard2 r:core_node5) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.c.SyncStrategy http://127.0.0.1:56022/solr/authCollection_shard2_replica_n2/ has no replicas [junit4] 2> 3488797 INFO (coreZkRegister-18349-thread-1-processing-n:127.0.0.1:56022_solr x:authCollection_shard2_replica_n2 c:authCollection s:shard2 r:core_node5) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/authCollection/leaders/shard2/leader after winning as /collections/authCollection/leader_elect/shard2/election/72152623852421138-core_node5-n_0000000001 [junit4] 2> 3488798 INFO (coreZkRegister-18349-thread-1-processing-n:127.0.0.1:56022_solr x:authCollection_shard2_replica_n2 c:authCollection s:shard2 r:core_node5) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:authCollection_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:56022/solr/authCollection_shard2_replica_n2/ shard2 [junit4] 2> 3488799 INFO (coreZkRegister-18349-thread-1-processing-n:127.0.0.1:56022_solr x:authCollection_shard2_replica_n2 c:authCollection s:shard2 r:core_node5) [n:127.0.0.1:56022_solr c:authCollection s:shard2 r:core_node5 x:auth [...truncated too long message...] ivotSmallTest, ChaosMonkeyNothingIsSafeTest, TestDistribDocBasedVersion, TestFuzzyAnalyzedSuggestions, TestSolrFieldCacheBean, TestFieldSortValues, TestTestInjection, ReplaceNodeNoTargetTest, TestTolerantUpdateProcessorRandomCloud, RAMDirectoryFactoryTest, TestCollectionAPIs, NodeLostTriggerTest, SmileWriterTest, MergeStrategyTest, BadComponentTest, TestBulkSchemaConcurrent, AddBlockUpdateTest, CoreAdminRequestStatusTest, DeleteStatusTest, ConcurrentCreateRoutedAliasTest, TestJavabinTupleStreamParser, TokenizerChainTest, DOMUtilTest, TestCopyFieldCollectionResource, TestHashPartitioner, TemplateUpdateProcessorTest, DirectUpdateHandlerTest, TestSQLHandler, CollectionsAPIAsyncDistributedZkTest, DistributedFacetPivotLongTailTest, TestFiltering, TestHdfsUpdateLog, TestDistributedStatsComponentCardinality, CategoryRoutedAliasUpdateProcessorTest, SolrIndexMetricsTest, TestDistribIDF, SuggesterTSTTest, TransactionLogTest, TestSolrIndexConfig, DeleteLastCustomShardedReplicaTest, TestLegacyNumericRangeQueryBuilder, PeerSyncWithLeaderAndIndexFingerprintCachingTest, TestSnapshotCloudManager, SolrJmxReporterTest, LeaderFailureAfterFreshStartTest, PhrasesIdentificationComponentTest, ExitableDirectoryReaderTest, TestManagedSchemaThreadSafety, TestLFUCache, SearchHandlerTest, TestMiniSolrCloudClusterSSL, SimpleFacetsTest, TestDirectoryFactory, BinaryUpdateRequestHandlerTest, TestLocalFSCloudBackupRestore, SolrInfoBeanTest, ReplicationFactorTest, TestSimGenericDistributedQueue, MetricsHistoryIntegrationTest, TestLeaderElectionZkExpiry, TestBackupRepositoryFactory, UnloadDistributedZkTest, TestTlogReplica, AuditLoggerIntegrationTest, TestComponentsName, SimpleCollectionCreateDeleteTest, TestJsonFacetsStatsParsing, TestRTGBase, HealthCheckHandlerTest, JvmMetricsTest, TestSolr4Spatial2, DistributedQueueTest, TestDownShardTolerantSearch, TestCryptoKeys, NotRequiredUniqueKeyTest, TestRecoveryHdfs, SolrCmdDistributorTest, MigrateRouteKeyTest, URLClassifyProcessorTest, ClassificationUpdateProcessorIntegrationTest, MoveReplicaTest, TestRTimerTree, CursorMarkTest, TestSegmentSorting, PluginInfoTest, CoreAdminHandlerTest, TestCollationFieldDocValues, MultiDestinationAuditLoggerTest, TestHdfsBackupRestoreCore, TestFieldCacheSort, DistributedMLTComponentTest, DocValuesTest, ResourceLoaderTest, TestClusterProperties, TestXIncludeConfig, BooleanFieldTest, ZkFailoverTest, TestPullReplicaErrorHandling, TestEmbeddedSolrServerSchemaAPI, CloneFieldUpdateProcessorFactoryTest, UniqFieldsUpdateProcessorFactoryTest, LoggingHandlerTest, TestSolrConfigHandlerCloud, TestReqParamsAPI, ScriptEngineTest, XmlInterpolationTest, TestInPlaceUpdatesDistrib, TestReplicationHandlerBackup, PrimUtilsTest, JWTAuthPluginIntegrationTest, TestSmileRequest, ShufflingReplicaListTransformerTest, TestSortByMinMaxFunction, DistributedFacetExistsSmallTest, SolrCLIZkUtilsTest, TestCloudDeleteByQuery, TestSearcherReuse, CloudExitableDirectoryReaderTest, TestExtendedDismaxParser, SparseHLLTest, TermVectorComponentTest, TestNumericTerms64, IndexSizeTriggerTest, DistributedDebugComponentTest, MaxSizeAutoCommitTest, TestPayloadScoreQParserPlugin, SortByFunctionTest, SystemInfoHandlerTest, TestPointFields, RecoveryAfterSoftCommitTest, IndexSchemaTest, CoreSorterTest, TestDynamicURP, SolrMetricReporterTest, CreateRoutedAliasTest, LeaderVoteWaitTimeoutTest, DaemonStreamApiTest, HdfsAutoAddReplicasIntegrationTest, OverseerTest, SuggestComponentTest, TestSha256AuthenticationProvider, TestDFISimilarityFactory, BJQParserTest, TestReloadDeadlock, DistributedTermsComponentTest, ShowFileRequestHandlerTest, CustomTermsComponentTest, TestFieldResource, DocValuesMissingTest, DirectSolrSpellCheckerTest, TestRandomRequestDistribution, TestCodecSupport, TestAnalyzedSuggestions, ScheduledTriggerIntegrationTest, TestNestedDocsSort, TestSurroundQueryParser, ExplicitHLLTest, SchemaApiFailureTest, ZkShardTermsTest, SearchRateTriggerIntegrationTest, TestJoin, LeaderElectionTest, TestGraphTermsQParserPlugin, TestLegacyTerms, EchoParamsTest, DirectSolrConnectionTest, TestIntervalFaceting, SortSpecParsingTest, TestStreamBody, TestJmxIntegration, HttpPartitionTest, TestDynamicFieldResource, DateFieldTest, AssignBackwardCompatibilityTest, TestValueSourceCache, TestGeoJSONResponseWriter, CdcrBidirectionalTest, HLLSerializationTest, TestSimNodeAddedTrigger, TestTrie, GraphQueryTest, TestDistributedSearch, TestDistributedGrouping, TestSizeLimitedDistributedMap, TestExactStatsCache, TestSolrCloudSnapshots, ConnectionReuseTest, TestSchemaResource, ReplicaListTransformerTest, DeleteReplicaTest, DistribJoinFromCollectionTest, DocValuesNotIndexedTest, ForceLeaderTest, ForceLeaderWithTlogReplicasTest, FullSolrCloudDistribCmdsTest, LeaderElectionContextKeyTest, LeaderElectionIntegrationTest, OverseerRolesTest, OverseerTaskQueueTest, RemoteQueryErrorTest, RollingRestartTest, RoutingToNodesWithPropertiesTest, SSLMigrationTest, SaslZkACLProviderTest, ShardRoutingCustomTest, ShardRoutingTest, SharedFSAutoReplicaFailoverTest, SliceStateTest, SplitShardTest, SystemCollectionCompatTest, TestAuthenticationFramework, TestCloudConsistency, TestCloudPseudoReturnFields, TestCloudRecovery, TestCloudSearcherWarming, TestSolrCloudWithSecureImpersonation, TestStressCloudBlindAtomicUpdates, TestStressLiveNodes, TlogReplayBufferedWhileIndexingTest, TriLevelCompositeIdRoutingTest, ZkCLITest, ConcurrentDeleteAndCreateCollectionTest, CustomCollectionTest, TestCollectionsAPIViaSolrCloudCluster, TestHdfsCloudBackupRestore, TestRequestStatusCollectionAPI, AutoAddReplicasIntegrationTest, AutoAddReplicasPlanActionTest, AutoScalingHandlerTest, ComputePlanActionTest, MetricTriggerTest, NodeAddedTriggerTest, RestoreTriggerStateTest, SystemLogListenerTest, TriggerCooldownIntegrationTest, TriggerSetPropertiesIntegrationTest, TestSimClusterStateProvider, TestSimComputePlanAction, TestSimDistribStateManager, TestSimDistributedQueue, TestSimExecutePlanAction, TestSimExtremeIndexing, TestSimPolicyCloud, TestSimTriggerIntegration, CdcrOpsAndBoundariesTest, CdcrReplicationHandlerTest, CdcrRequestHandlerTest, CdcrVersionReplicationTest, ZkStateWriterTest, ByteBuffersDirectoryFactoryTest, CachingDirectoryFactoryTest, TestConfigOverlay, TestConfigSetImmutable, TestConfigSetProperties, TestConfigSets, TestCoreDiscovery, TestCorePropertiesReload, TestInfoStreamLogging, TestInitParams, TestMergePolicyConfig, TestNRTOpen, TestQuerySenderListener, TestQuerySenderNoQuery, TestReloadAndDeleteDocs, TestSolrDeletionPolicy1, TestSolrDeletionPolicy2, DocumentAnalysisRequestHandlerTest, FieldAnalysisRequestHandlerTest, JsonLoaderTest, MoreLikeThisHandlerTest, PingRequestHandlerTest, RequestLoggingTest, SearchHandlerTest, TestCSVLoader, TestConfigReload, TestSystemCollAutoCreate, CoreAdminCreateDiscoverTest, MBeansHandlerTest, MetricsHandlerTest, MetricsHistoryHandlerTest, PropertiesRequestHandlerTest, SecurityConfHandlerTest, SegmentsInfoRequestHandlerTest, DistributedQueryComponentOptimizationTest, DistributedSpellCheckComponentTest, MoreLikeThisComponentTest, StatsComponentTest, TestExportWriter, JavabinLoaderTest, EmbeddedSolrNoSerializeTest, RandomizedTaggerTest, TaggerTest, HighlighterConfigTest, HighlighterTest, TestSlowCompositeReaderWrapper, UninvertDocValuesMergePolicyTest, TestNumericRangeQuery32, SolrCoreMetricManagerTest, SolrJmxReporterCloudTest, SolrShardReporterTest, TestMacroExpander, TestCSVResponseWriter, TestPushWriter, TestRawResponseWriter, TestRetrieveFieldsOptimizer, TestSubQueryTransformerDistrib, TestManagedSynonymFilterFactory, TestManagedSynonymGraphFilterFactory, BadCopyFieldTest, BadIndexSchemaTest, CopyFieldTest, CurrencyFieldTypeTest, PolyFieldTest, PreAnalyzedFieldTest, PrimitiveFieldTypeTest, RequiredFieldsTest, SpatialRPTFieldTypeTest, TestCollationField, TestManagedSchema, TestSchemalessBufferedUpdates, TestSortableTextField, UUIDFieldTest, AnalyticsQueryTest, CurrencyRangeFacetCloudTest, QueryParsingTest, RankQueryTest, SignificantTermsQParserPluginTest, TestAddFieldRealTimeGet, TestComplexPhraseLeadingWildcard, TestComplexPhraseQParserPlugin, TestIndexSearcher, TestOverriddenPrefixQueryForCustomFieldType, TestRangeQuery, TestSolrQueryParser, TestSort, TestStandardQParsers, TestStressLucene, TestStressRecovery, TestStressReorder, TestStressUserVersions, TestStressVersions, TestXmlQParserPlugin, DistributedFacetSimpleRefinementLongTailTest, RangeFacetCloudTest, SpatialHeatmapFacetsTest, TestMinMaxOnMultiValuedField, TestOrdValues, BlockJoinFacetRandomTest, BlockJoinFacetSimpleTest, TestScoreJoinQPScore, TestJsonRequest, CloudMLTQParserTest, SimpleMLTQParserTest, TestBM25SimilarityFactory, TestClassicSimilarityFactory, TestIBSimilarityFactory, TestLMDirichletSimilarityFactory, TestLMJelinekMercerSimilarityFactory, TestLegacyBM25SimilarityFactory, TestNonDefinedSimilarityFactory, TestPerFieldSimilarity, TestPerFieldSimilarityWithDefaultOverride, TestSweetSpotSimilarityFactory, BasicAuthIntegrationTest] [junit4] Completed [780/858 (1!)] on J0 in 9.35s, 1 test, 1 error <<< FAILURES! [...truncated 43496 lines...] [repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/7969/consoleText [repro] Revision: 1ff7b2942c2030a125e9a3fecfd40e4f2784eba9 [repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UseG1GC" [repro] ant clean [...truncated 6 lines...] [repro] Test suites by module: [repro] solr\core [repro] BasicAuthIntegrationTest [repro] ant compile-test [...truncated 3332 lines...] [repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.BasicAuthIntegrationTest" -Dtests.showOutput=onerror "-Dargs=-XX:+UseCompressedOops -XX:+UseG1GC" -Dtests.seed=54734BA451F87FA9 -Dtests.slow=true -Dtests.locale=en-FJ -Dtests.timezone=Europe/Samara -Dtests.asserts=true -Dtests.file.encoding=Cp1252 [...truncated 73 lines...] [repro] Failures: [repro] 0/5 failed: org.apache.solr.security.BasicAuthIntegrationTest [repro] Exiting with code 0 [...truncated 78 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
