Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.0-Windows/167/
Java: 64bit/jdk-9-ea+181 -XX:+UseCompressedOops -XX:+UseG1GC
--illegal-access=deny
2 tests failed.
FAILED: org.apache.solr.security.BasicAuthIntegrationTest.testBasicAuth
Error Message:
expected:<200> but was:<403>
Stack Trace:
java.lang.AssertionError: expected:<200> but was:<403>
at
__randomizedtesting.SeedInfo.seed([9A20E5C150D9C69F:264E93D3F48A45E5]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at
org.apache.solr.security.BasicAuthIntegrationTest.executeCommand(BasicAuthIntegrationTest.java:242)
at
org.apache.solr.security.BasicAuthIntegrationTest.testBasicAuth(BasicAuthIntegrationTest.java:154)
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:564)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
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:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
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:844)
FAILED: org.apache.solr.client.solrj.TestLBHttpSolrClient.testSimple
Error Message:
expected:<3> but was:<2>
Stack Trace:
java.lang.AssertionError: expected:<3> but was:<2>
at
__randomizedtesting.SeedInfo.seed([EBC40A5260ADFE9D:D3772EAC475E2A4C]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at
org.apache.solr.client.solrj.TestLBHttpSolrClient.testSimple(TestLBHttpSolrClient.java:170)
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:564)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
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:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
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:844)
Build Log:
[...truncated 11556 lines...]
[junit4] Suite: org.apache.solr.security.BasicAuthIntegrationTest
[junit4] 2> Creating dataDir:
C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_9A20E5C150D9C69F-001\init-core-data-001
[junit4] 2> 850591 WARN
(SUITE-BasicAuthIntegrationTest-seed#[9A20E5C150D9C69F]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2
[junit4] 2> 850591 INFO
(SUITE-BasicAuthIntegrationTest-seed#[9A20E5C150D9C69F]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 850593 INFO
(SUITE-BasicAuthIntegrationTest-seed#[9A20E5C150D9C69F]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0,
clientAuth=0.0/0.0)
[junit4] 2> 850594 INFO
(SUITE-BasicAuthIntegrationTest-seed#[9A20E5C150D9C69F]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 3 servers in
C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_9A20E5C150D9C69F-001\tempDir-001
[junit4] 2> 850595 INFO
(SUITE-BasicAuthIntegrationTest-seed#[9A20E5C150D9C69F]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 850595 INFO (Thread-2320) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 850595 INFO (Thread-2320) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 850599 ERROR (Thread-2320) [ ] o.a.z.s.ZooKeeperServer
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action
on ERROR or SHUTDOWN server state changes
[junit4] 2> 850696 INFO
(SUITE-BasicAuthIntegrationTest-seed#[9A20E5C150D9C69F]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:49313
[junit4] 2> 850704 INFO (jetty-launcher-2544-thread-1) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 850704 INFO (jetty-launcher-2544-thread-2) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 850705 INFO (jetty-launcher-2544-thread-3) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 850705 INFO (jetty-launcher-2544-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@3a1980dd{/solr,null,AVAILABLE}
[junit4] 2> 850705 INFO (jetty-launcher-2544-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@6c2029f4{/solr,null,AVAILABLE}
[junit4] 2> 850705 INFO (jetty-launcher-2544-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@4dc2d853{/solr,null,AVAILABLE}
[junit4] 2> 850705 INFO (jetty-launcher-2544-thread-3) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@37fa292a{HTTP/1.1,[http/1.1]}{127.0.0.1:49320}
[junit4] 2> 850705 INFO (jetty-launcher-2544-thread-3) [ ]
o.e.j.s.Server Started @853019ms
[junit4] 2> 850705 INFO (jetty-launcher-2544-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=49320}
[junit4] 2> 850705 INFO (jetty-launcher-2544-thread-1) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@29090af{HTTP/1.1,[http/1.1]}{127.0.0.1:49323}
[junit4] 2> 850705 INFO (jetty-launcher-2544-thread-2) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@58148c57{HTTP/1.1,[http/1.1]}{127.0.0.1:49317}
[junit4] 2> 850705 INFO (jetty-launcher-2544-thread-1) [ ]
o.e.j.s.Server Started @853019ms
[junit4] 2> 850705 INFO (jetty-launcher-2544-thread-2) [ ]
o.e.j.s.Server Started @853019ms
[junit4] 2> 850705 INFO (jetty-launcher-2544-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=49323}
[junit4] 2> 850705 INFO (jetty-launcher-2544-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=49317}
[junit4] 2> 850705 ERROR (jetty-launcher-2544-thread-2) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 850705 ERROR (jetty-launcher-2544-thread-1) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 850705 INFO (jetty-launcher-2544-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.0.0
[junit4] 2> 850705 INFO (jetty-launcher-2544-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.0.0
[junit4] 2> 850705 INFO (jetty-launcher-2544-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 850705 INFO (jetty-launcher-2544-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 850705 INFO (jetty-launcher-2544-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 850705 INFO (jetty-launcher-2544-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 850709 INFO (jetty-launcher-2544-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-09-17T17:18:33.597613600Z
[junit4] 2> 850709 INFO (jetty-launcher-2544-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-09-17T17:18:33.601716400Z
[junit4] 2> 850710 ERROR (jetty-launcher-2544-thread-3) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 850710 INFO (jetty-launcher-2544-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.0.0
[junit4] 2> 850710 INFO (jetty-launcher-2544-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 850710 INFO (jetty-launcher-2544-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 850710 INFO (jetty-launcher-2544-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-09-17T17:18:33.602231500Z
[junit4] 2> 850718 INFO (jetty-launcher-2544-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 850725 INFO (jetty-launcher-2544-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 850727 INFO (jetty-launcher-2544-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:49313/solr
[junit4] 2> 850732 INFO (jetty-launcher-2544-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 850740 INFO (jetty-launcher-2544-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:49313/solr
[junit4] 2> 850746 INFO (jetty-launcher-2544-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:49313/solr
[junit4] 2> 850749 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15e90d94c120004, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2> 850749 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15e90d94c120005, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2> 850877 INFO (jetty-launcher-2544-thread-3) [ ]
o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 850877 INFO (jetty-launcher-2544-thread-1) [ ]
o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 850877 INFO (jetty-launcher-2544-thread-2) [ ]
o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 850877 INFO (jetty-launcher-2544-thread-3) [ ]
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:49320_solr
[junit4] 2> 850878 INFO (jetty-launcher-2544-thread-1) [ ]
o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:49323_solr
[junit4] 2> 850878 INFO (jetty-launcher-2544-thread-2) [ ]
o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:49317_solr
[junit4] 2> 850879 INFO (jetty-launcher-2544-thread-3) [ ]
o.a.s.c.Overseer Overseer
(id=98675504807280647-127.0.0.1:49320_solr-n_0000000000) starting
[junit4] 2> 850880 INFO (zkCallback-2561-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 850880 INFO (zkCallback-2560-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 850880 INFO (zkCallback-2559-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 850888 INFO (jetty-launcher-2544-thread-3) [ ]
o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:49320_solr
[junit4] 2> 850917 INFO (zkCallback-2559-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 850917 INFO (zkCallback-2560-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 850917 INFO (zkCallback-2561-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 850950 INFO (jetty-launcher-2544-thread-3) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_49320.solr.node' (registry
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@140e2849
[junit4] 2> 850952 INFO (jetty-launcher-2544-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_49323.solr.node' (registry
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@140e2849
[junit4] 2> 850959 INFO (jetty-launcher-2544-thread-3) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_49320.solr.jvm' (registry
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@140e2849
[junit4] 2> 850959 INFO (jetty-launcher-2544-thread-3) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_49320.solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@140e2849
[junit4] 2> 850960 INFO (jetty-launcher-2544-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_49323.solr.jvm' (registry
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@140e2849
[junit4] 2> 850960 INFO (jetty-launcher-2544-thread-3) [ ]
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_9A20E5C150D9C69F-001\tempDir-001\node3\.
[junit4] 2> 850960 INFO (jetty-launcher-2544-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_49323.solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@140e2849
[junit4] 2> 850961 INFO (jetty-launcher-2544-thread-1) [ ]
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_9A20E5C150D9C69F-001\tempDir-001\node1\.
[junit4] 2> 850962 INFO (jetty-launcher-2544-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_49317.solr.node' (registry
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@140e2849
[junit4] 2> 850968 INFO (jetty-launcher-2544-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_49317.solr.jvm' (registry
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@140e2849
[junit4] 2> 850968 INFO (jetty-launcher-2544-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_49317.solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@140e2849
[junit4] 2> 850969 INFO (jetty-launcher-2544-thread-2) [ ]
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_9A20E5C150D9C69F-001\tempDir-001\node2\.
[junit4] 2> 851044 INFO
(SUITE-BasicAuthIntegrationTest-seed#[9A20E5C150D9C69F]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 851045 INFO
(SUITE-BasicAuthIntegrationTest-seed#[9A20E5C150D9C69F]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:49313/solr ready
[junit4] 2> 851053 INFO (qtp61369407-12769) [ ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=1&collection.configName=conf&name=authCollection&nrtReplicas=1&action=CREATE&numShards=3&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 851056 INFO (OverseerThreadFactory-4523-thread-1) [ ]
o.a.s.c.CreateCollectionCmd Create collection authCollection
[junit4] 2> 851163 INFO
(OverseerStateUpdate-98675504807280647-127.0.0.1:49320_solr-n_0000000000) [
] 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:49317/solr";,
[junit4] 2> "type":"NRT"}
[junit4] 2> 851165 INFO
(OverseerStateUpdate-98675504807280647-127.0.0.1:49320_solr-n_0000000000) [
] 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_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:49323/solr";,
[junit4] 2> "type":"NRT"}
[junit4] 2> 851166 INFO
(OverseerStateUpdate-98675504807280647-127.0.0.1:49320_solr-n_0000000000) [
] 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_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:49320/solr";,
[junit4] 2> "type":"NRT"}
[junit4] 2> 851367 INFO (qtp61369407-12772) [ ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=authCollection_shard2_replica_n1&action=CREATE&numShards=3&collection=authCollection&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 851367 INFO (qtp2099911422-12761) [ ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node1&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> 851370 INFO (qtp1560120301-12767) [ ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=authCollection_shard3_replica_n1&action=CREATE&numShards=3&collection=authCollection&shard=shard3&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 851371 INFO (qtp2099911422-12761) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 851371 INFO (qtp61369407-12772) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 851371 INFO (qtp1560120301-12767) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 851481 INFO (zkCallback-2559-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> 851481 INFO (zkCallback-2561-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> 851481 INFO (zkCallback-2560-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> 851482 INFO (zkCallback-2560-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> 851482 INFO (zkCallback-2561-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> 851482 INFO (zkCallback-2559-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> 852386 INFO (qtp2099911422-12761) [ ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 7.0.0
[junit4] 2> 852388 INFO (qtp61369407-12772) [ ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 7.0.0
[junit4] 2> 852391 INFO (qtp1560120301-12767) [ ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 7.0.0
[junit4] 2> 852392 INFO (qtp2099911422-12761) [ ] o.a.s.s.IndexSchema
[authCollection_shard1_replica_n1] Schema name=minimal
[junit4] 2> 852394 INFO (qtp2099911422-12761) [ ] o.a.s.s.IndexSchema
Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 852394 INFO (qtp2099911422-12761) [ ]
o.a.s.c.CoreContainer Creating SolrCore 'authCollection_shard1_replica_n1'
using configuration from collection authCollection, trusted=true
[junit4] 2> 852394 INFO (qtp2099911422-12761) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_49317.solr.core.authCollection.shard1.replica_n1' (registry
'solr.core.authCollection.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@140e2849
[junit4] 2> 852394 INFO (qtp2099911422-12761) [ ] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 852394 INFO (qtp2099911422-12761) [ ] o.a.s.c.SolrCore
[[authCollection_shard1_replica_n1] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_9A20E5C150D9C69F-001\tempDir-001\node2\authCollection_shard1_replica_n1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_9A20E5C150D9C69F-001\tempDir-001\node2\.\authCollection_shard1_replica_n1\data\]
[junit4] 2> 852395 INFO (qtp61369407-12772) [ ] o.a.s.s.IndexSchema
[authCollection_shard2_replica_n1] Schema name=minimal
[junit4] 2> 852408 INFO (qtp61369407-12772) [ ] o.a.s.s.IndexSchema
Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 852408 INFO (qtp61369407-12772) [ ] o.a.s.c.CoreContainer
Creating SolrCore 'authCollection_shard2_replica_n1' using configuration from
collection authCollection, trusted=true
[junit4] 2> 852409 INFO (qtp61369407-12772) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_49323.solr.core.authCollection.shard2.replica_n1' (registry
'solr.core.authCollection.shard2.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@140e2849
[junit4] 2> 852409 INFO (qtp61369407-12772) [ ] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 852409 INFO (qtp61369407-12772) [ ] o.a.s.c.SolrCore
[[authCollection_shard2_replica_n1] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_9A20E5C150D9C69F-001\tempDir-001\node1\authCollection_shard2_replica_n1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_9A20E5C150D9C69F-001\tempDir-001\node1\.\authCollection_shard2_replica_n1\data\]
[junit4] 2> 852412 INFO (qtp1560120301-12767) [ ] o.a.s.s.IndexSchema
[authCollection_shard3_replica_n1] Schema name=minimal
[junit4] 2> 852413 INFO (qtp1560120301-12767) [ ] o.a.s.s.IndexSchema
Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 852413 INFO (qtp1560120301-12767) [ ]
o.a.s.c.CoreContainer Creating SolrCore 'authCollection_shard3_replica_n1'
using configuration from collection authCollection, trusted=true
[junit4] 2> 852414 INFO (qtp1560120301-12767) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_49320.solr.core.authCollection.shard3.replica_n1' (registry
'solr.core.authCollection.shard3.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@140e2849
[junit4] 2> 852414 INFO (qtp1560120301-12767) [ ] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 852414 INFO (qtp1560120301-12767) [ ] o.a.s.c.SolrCore
[[authCollection_shard3_replica_n1] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_9A20E5C150D9C69F-001\tempDir-001\node3\authCollection_shard3_replica_n1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_9A20E5C150D9C69F-001\tempDir-001\node3\.\authCollection_shard3_replica_n1\data\]
[junit4] 2> 852512 INFO (qtp2099911422-12761) [ ]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 852512 INFO (qtp2099911422-12761) [ ] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 852514 INFO (qtp2099911422-12761) [ ]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 852514 INFO (qtp2099911422-12761) [ ]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 852541 INFO (qtp1560120301-12767) [ ]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 852541 INFO (qtp1560120301-12767) [ ] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 852543 INFO (qtp1560120301-12767) [ ]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 852543 INFO (qtp1560120301-12767) [ ]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 852545 INFO (qtp2099911422-12761) [ ]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@c490b03[authCollection_shard1_replica_n1] main]
[junit4] 2> 852546 INFO (qtp2099911422-12761) [ ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 852546 INFO (qtp2099911422-12761) [ ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 852548 INFO (qtp2099911422-12761) [ ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 852548 INFO (qtp1560120301-12767) [ ]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@3c158558[authCollection_shard3_replica_n1] main]
[junit4] 2> 852548 INFO (qtp2099911422-12761) [ ] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1578808078961213440
[junit4] 2> 852549 INFO (searcherExecutor-4527-thread-1) [ ]
o.a.s.c.SolrCore [authCollection_shard1_replica_n1] Registered new searcher
Searcher@c490b03[authCollection_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 852549 INFO (qtp1560120301-12767) [ ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 852551 INFO (qtp1560120301-12767) [ ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 852551 INFO (qtp1560120301-12767) [ ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 852553 INFO (searcherExecutor-4529-thread-1) [ ]
o.a.s.c.SolrCore [authCollection_shard3_replica_n1] Registered new searcher
Searcher@3c158558[authCollection_shard3_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 852553 INFO (qtp1560120301-12767) [ ] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1578808078966456320
[junit4] 2> 852558 INFO (qtp2099911422-12761) [ ]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 852558 INFO (qtp2099911422-12761) [ ]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 852558 INFO (qtp2099911422-12761) [ ] o.a.s.c.SyncStrategy
Sync replicas to http://127.0.0.1:49317/solr/authCollection_shard1_replica_n1/
[junit4] 2> 852558 INFO (qtp2099911422-12761) [ ] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 852558 INFO (qtp2099911422-12761) [ ] o.a.s.c.SyncStrategy
http://127.0.0.1:49317/solr/authCollection_shard1_replica_n1/ has no replicas
[junit4] 2> 852558 INFO (qtp2099911422-12761) [ ]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 852562 INFO (qtp1560120301-12767) [ ]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 852562 INFO (qtp1560120301-12767) [ ]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 852562 INFO (qtp1560120301-12767) [ ] o.a.s.c.SyncStrategy
Sync replicas to http://127.0.0.1:49320/solr/authCollection_shard3_replica_n1/
[junit4] 2> 852562 INFO (qtp1560120301-12767) [ ] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 852562 INFO (qtp1560120301-12767) [ ] o.a.s.c.SyncStrategy
http://127.0.0.1:49320/solr/authCollection_shard3_replica_n1/ has no replicas
[junit4] 2> 852562 INFO (qtp1560120301-12767) [ ]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 852563 INFO (qtp2099911422-12761) [ ]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:49317/solr/authCollection_shard1_replica_n1/ shard1
[junit4] 2> 852566 INFO (qtp1560120301-12767) [ ]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:49320/solr/authCollection_shard3_replica_n1/ shard3
[junit4] 2> 852577 INFO (qtp61369407-12772) [ ] o.a.s.u.UpdateHandler
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 852577 INFO (qtp61369407-12772) [ ] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 852580 INFO (qtp61369407-12772) [ ] o.a.s.u.CommitTracker
Hard AutoCommit: disabled
[junit4] 2> 852580 INFO (qtp61369407-12772) [ ] o.a.s.u.CommitTracker
Soft AutoCommit: disabled
[junit4] 2> 852582 INFO (qtp61369407-12772) [ ]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@6b240dd6[authCollection_shard2_replica_n1] main]
[junit4] 2> 852583 INFO (qtp61369407-12772) [ ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 852584 INFO (qtp61369407-12772) [ ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 852584 INFO (qtp61369407-12772) [ ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 852584 INFO (qtp61369407-12772) [ ] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1578808078998962176
[junit4] 2> 852585 INFO (searcherExecutor-4528-thread-1) [ ]
o.a.s.c.SolrCore [authCollection_shard2_replica_n1] Registered new searcher
Searcher@6b240dd6[authCollection_shard2_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 852594 INFO (qtp61369407-12772) [ ]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 852594 INFO (qtp61369407-12772) [ ]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 852595 INFO (qtp61369407-12772) [ ] o.a.s.c.SyncStrategy
Sync replicas to http://127.0.0.1:49323/solr/authCollection_shard2_replica_n1/
[junit4] 2> 852595 INFO (qtp61369407-12772) [ ] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 852595 INFO (qtp61369407-12772) [ ] o.a.s.c.SyncStrategy
http://127.0.0.1:49323/solr/authCollection_shard2_replica_n1/ has no replicas
[junit4] 2> 852595 INFO (qtp61369407-12772) [ ]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 852598 INFO (qtp61369407-12772) [ ]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:49323/solr/authCollection_shard2_replica_n1/ shard2
[junit4] 2> 852701 INFO (zkCallback-2559-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> 852701 INFO (zkCallback-2561-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> 852701 INFO (zkCallback-2561-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> 852701 INFO (zkCallback-2560-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> 852701 INFO (zkCallback-2560-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> 852701 INFO (zkCallback-2559-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> 852715 INFO (qtp2099911422-12761) [ ] o.a.s.c.ZkController
I am the leader, no recovery necessary
[junit4] 2> 852716 INFO (qtp2099911422-12761) [ ] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node1&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=1348
[junit4] 2> 852717 INFO (qtp1560120301-12767) [ ] o.a.s.c.ZkController
I am the leader, no recovery necessary
[junit4] 2> 852718 INFO (qtp1560120301-12767) [ ] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=authCollection_shard3_replica_n1&action=CREATE&numShards=3&collection=authCollection&shard=shard3&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1350
[junit4] 2> 852749 INFO (qtp61369407-12772) [ ] o.a.s.c.ZkController I
am the leader, no recovery necessary
[junit4] 2> 852751 INFO (qtp61369407-12772) [ ] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=authCollection_shard2_replica_n1&action=CREATE&numShards=3&collection=authCollection&shard=shard2&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1382
[junit4] 2> 852753 INFO (qtp61369407-12769) [ ]
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most
30 seconds. Check all shard replicas
[junit4] 2> 852853 INFO (zkCallback-2559-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> 852853 INFO (zkCallback-2559-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> 852853 INFO (zkCallback-2561-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> 852853 INFO (zkCallback-2561-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> 852853 INFO (zkCallback-2560-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> 852853 INFO (zkCallback-2560-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> 853057 INFO
(OverseerCollectionConfigSetProcessor-98675504807280647-127.0.0.1:49320_solr-n_0000000000)
[ ] 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> 853753 INFO (qtp61369407-12769) [ ] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/collections
params={replicationFactor=1&collection.configName=conf&name=authCollection&nrtReplicas=1&action=CREATE&numShards=3&wt=javabin&version=2}
status=0 QTime=2700
[junit4] 2> 853789 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testBasicAuth
[junit4] 2> 853793 INFO (qtp1560120301-12781) [ ] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/authentication params={} status=0 QTime=0
[junit4] 2> 853795 INFO (qtp1560120301-12782) [ ] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/authentication params={} status=0 QTime=0
[junit4] 2> 853796 INFO (zkCallback-2560-thread-1) [ ]
o.a.s.c.CoreContainer Security node changed, reloading security.json
[junit4] 2> 853798 INFO (zkCallback-2560-thread-1) [ ]
o.a.s.c.CoreContainer Initializing authorization plugin:
solr.RuleBasedAuthorizationPlugin
[junit4] 2> 853798 INFO (zkCallback-2559-thread-1) [ ]
o.a.s.c.CoreContainer Security node changed, reloading security.json
[junit4] 2> 853796 INFO (zkCallback-2561-thread-2) [ ]
o.a.s.c.CoreContainer Security node changed, reloading security.json
[junit4] 2> 853798 INFO (zkCallback-2559-thread-1) [ ]
o.a.s.c.CoreContainer Initializing authorization plugin:
solr.RuleBasedAuthorizationPlugin
[junit4] 2> 853798 INFO (zkCallback-2561-thread-2) [ ]
o.a.s.c.CoreContainer Initializing authorization plugin:
solr.RuleBasedAuthorizationPlugin
[junit4] 2> 853820 INFO (zkCallback-2560-thread-1) [ ]
o.a.s.c.CoreContainer Initializing authentication plugin: solr.BasicAuthPlugin
[junit4] 2> 853820 INFO (zkCallback-2561-thread-2) [ ]
o.a.s.c.CoreContainer Initializing authentication plugin: solr.BasicAuthPlugin
[junit4] 2> 853820 INFO (zkCallback-2559-thread-1) [ ]
o.a.s.c.CoreContainer Initializing authentication plugin: solr.BasicAuthPlugin
[junit4] 2> 853835 INFO (zkCallback-2559-thread-1) [ ]
o.a.s.c.CoreContainer PKIAuthenticationPlugin is managing internode requests
[junit4] 2> 853835 INFO (zkCallback-2561-thread-2) [ ]
o.a.s.c.CoreContainer PKIAuthenticationPlugin is managing internode requests
[junit4] 2> 853835 INFO (zkCallback-2560-thread-1) [ ]
o.a.s.c.CoreContainer PKIAuthenticationPlugin is managing internode requests
[junit4] 2> 853848 INFO (qtp1560120301-12782) [ ] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/authentication params={} status=0 QTime=1
[junit4] 2> 853849 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@37fa292a{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 853849 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=201614475
[junit4] 2> 853850 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 853850 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@e78412: rootName =
solr_49320, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@40dbfa03
[junit4] 2> 853855 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 853855 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@16149c49: rootName =
solr_49320, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@b8aa026
[junit4] 2> 853859 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 853859 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@743756cb: rootName =
solr_49320, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@16a3710a
[junit4] 2> 853861 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 853862 INFO (coreCloseExecutor-4542-thread-1) [ ]
o.a.s.c.SolrCore [authCollection_shard3_replica_n1] CLOSING SolrCore
org.apache.solr.core.SolrCore@17d55410
[junit4] 2> 853862 INFO (coreCloseExecutor-4542-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.authCollection.shard3.replica_n1, tag=399856656
[junit4] 2> 853862 INFO (coreCloseExecutor-4542-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@475cc6c5: rootName =
solr_49320, domain = solr.core.authCollection.shard3.replica_n1, service url =
null, agent id = null] for registry solr.core.authCollection.shard3.replica_n1
/ com.codahale.metrics.MetricRegistry@3616188
[junit4] 2> 853868 INFO (coreCloseExecutor-4542-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.collection.authCollection.shard3.leader, tag=399856656
[junit4] 2> 853869 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.c.Overseer Overseer
(id=98675504807280647-127.0.0.1:49320_solr-n_0000000000) closing
[junit4] 2> 853869 INFO
(OverseerStateUpdate-98675504807280647-127.0.0.1:49320_solr-n_0000000000) [
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:49320_solr
[junit4] 2> 853870 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15e90d94c120007, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2> 853870 WARN (zkCallback-2560-thread-1) [ ]
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK:
[KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 853870 INFO (zkCallback-2568-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 853870 INFO (zkCallback-2561-thread-2) [ ]
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:49323_solr
[junit4] 2> 853871 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@6c2029f4{/solr,null,UNAVAILABLE}
[junit4] 2> 853871 INFO (zkCallback-2561-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 853871 INFO (zkCallback-2559-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 853873 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 853873 INFO (zkCallback-2561-thread-2) [ ]
o.a.s.c.Overseer Overseer
(id=98675504807280649-127.0.0.1:49323_solr-n_0000000001) starting
[junit4] 2> 853873 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@73bf5a3c{/solr,null,AVAILABLE}
[junit4] 2> 853873 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@6d04f11a{HTTP/1.1,[http/1.1]}{127.0.0.1:49364}
[junit4] 2> 853874 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.e.j.s.Server Started @856185ms
[junit4] 2> 853874 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=49364}
[junit4] 2> 853874 ERROR
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 853875 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.0.0
[junit4] 2> 853875 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 853875 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 853875 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-09-17T17:18:36.767626600Z
[junit4] 2> 853883 INFO (zkCallback-2559-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> 853883 INFO (zkCallback-2559-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> 853883 INFO (zkCallback-2561-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> 853883 INFO (zkCallback-2561-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> 853886 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 853895 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:49313/solr
[junit4] 2> 853906 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 853907 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 853909 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:49364_solr
[junit4] 2> 853911 INFO (zkCallback-2568-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 853911 INFO (zkCallback-2559-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 853912 INFO (zkCallback-2561-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 853912 INFO (zkCallback-2573-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 853924 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.c.CoreContainer Initializing authorization plugin:
solr.RuleBasedAuthorizationPlugin
[junit4] 2> 853924 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.c.CoreContainer Initializing authentication plugin: solr.BasicAuthPlugin
[junit4] 2> 853924 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.c.CoreContainer PKIAuthenticationPlugin is managing internode requests
[junit4] 2> 853953 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_49364.solr.node' (registry
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@140e2849
[junit4] 2> 853961 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_49364.solr.jvm' (registry
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@140e2849
[junit4] 2> 853961 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_49364.solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@140e2849
[junit4] 2> 853963 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_9A20E5C150D9C69F-001\tempDir-001\node3\.
[junit4] 2> 853963 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.c.CorePropertiesLocator Cores are: [authCollection_shard3_replica_n1]
[junit4] 2> 853964 INFO (coreLoadExecutor-4551-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 854068 INFO (zkCallback-2559-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> 854068 INFO (zkCallback-2573-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> 854068 INFO (zkCallback-2561-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> 854068 INFO (zkCallback-2561-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> 854068 INFO (zkCallback-2559-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> 854069 INFO (zkCallback-2573-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> 854979 INFO (coreLoadExecutor-4551-thread-1) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 854988 INFO (coreLoadExecutor-4551-thread-1) [ ]
o.a.s.s.IndexSchema [authCollection_shard3_replica_n1] Schema name=minimal
[junit4] 2> 854990 INFO (coreLoadExecutor-4551-thread-1) [ ]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 854991 INFO (coreLoadExecutor-4551-thread-1) [ ]
o.a.s.c.CoreContainer Creating SolrCore 'authCollection_shard3_replica_n1'
using configuration from collection authCollection, trusted=true
[junit4] 2> 854991 INFO (coreLoadExecutor-4551-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_49364.solr.core.authCollection.shard3.replica_n1' (registry
'solr.core.authCollection.shard3.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@140e2849
[junit4] 2> 854991 INFO (coreLoadExecutor-4551-thread-1) [ ]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 854991 INFO (coreLoadExecutor-4551-thread-1) [ ]
o.a.s.c.SolrCore [[authCollection_shard3_replica_n1] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_9A20E5C150D9C69F-001\tempDir-001\node3\authCollection_shard3_replica_n1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_9A20E5C150D9C69F-001\tempDir-001\node3\.\authCollection_shard3_replica_n1\data\]
[junit4] 2> 855050 INFO (coreLoadExecutor-4551-thread-1) [ ]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 855050 INFO (coreLoadExecutor-4551-thread-1) [ ]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 855051 INFO (coreLoadExecutor-4551-thread-1) [ ]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 855051 INFO (coreLoadExecutor-4551-thread-1) [ ]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 855051 INFO (coreLoadExecutor-4551-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@77ebb890[authCollection_shard3_replica_n1] main]
[junit4] 2> 855053 INFO (coreLoadExecutor-4551-thread-1) [ ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 855053 INFO (coreLoadExecutor-4551-thread-1) [ ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 855053 INFO (coreLoadExecutor-4551-thread-1) [ ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 855054 INFO (coreLoadExecutor-4551-thread-1) [ ]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1578808081588944896
[junit4] 2> 855054 INFO (searcherExecutor-4552-thread-1) [ ]
o.a.s.c.SolrCore [authCollection_shard3_replica_n1] Registered new searcher
Searcher@77ebb890[authCollection_shard3_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 855058 INFO (coreZkRegister-4546-thread-1) [ ]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 855058 INFO (coreZkRegister-4546-thread-1) [ ]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 855058 INFO (coreZkRegister-4546-thread-1) [ ]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:49364/solr/authCollection_shard3_replica_n1/
[junit4] 2> 855058 INFO (coreZkRegister-4546-thread-1) [ ]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 855058 INFO (coreZkRegister-4546-thread-1) [ ]
o.a.s.c.SyncStrategy
http://127.0.0.1:49364/solr/authCollection_shard3_replica_n1/ has no replicas
[junit4] 2> 855058 INFO (coreZkRegister-4546-thread-1) [ ]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 855060 INFO (coreZkRegister-4546-thread-1) [ ]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:49364/solr/authCollection_shard3_replica_n1/ shard3
[junit4] 2> 855060 INFO (coreZkRegister-4546-thread-1) [ ]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 855164 INFO (zkCallback-2559-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> 855164 INFO (zkCallback-2573-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> 855164 INFO (zkCallback-2573-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> 855164 INFO (zkCallback-2561-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> 855164 INFO (zkCallback-2559-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> 855164 INFO (zkCallback-2561-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> 855493 INFO (qtp682035304-12872) [ ] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/authentication params={} status=0 QTime=0
[junit4] 2> 855495 INFO (qtp61369407-12773) [ ]
o.a.s.s.RuleBasedAuthorizationPlugin request has come without principal. failed
permission {
[junit4] 2> "name":"security-edit",
[junit4] 2> "role":"admin"}
[junit4] 2> 855496 INFO (qtp61369407-12773) [ ] o.a.s.s.HttpSolrCall
USER_REQUIRED auth header null context : userPrincipal: [null] type: [ADMIN],
collections: [], Path: [/admin/authentication] path : /admin/authentication
params :wt=javabin&version=2
[junit4] 2> 855504 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.s.BasicAuthIntegrationTest Added Basic Auth security Header
c29scjpTb2xyUm9ja3M=
[junit4] 2> 855506 INFO (qtp682035304-12873) [ ] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/authentication params={} status=0 QTime=0
[junit4] 2> 855516 INFO (qtp682035304-12874) [ ] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/authentication params={} status=0 QTime=3
[junit4] 2> 855517 INFO (zkCallback-2559-thread-2) [ ]
o.a.s.c.CoreContainer Security node changed, reloading security.json
[junit4] 2> 855517 INFO (zkCallback-2561-thread-1) [ ]
o.a.s.c.CoreContainer Security node changed, reloading security.json
[junit4] 2> 855517 INFO (zkCallback-2559-thread-2) [ ]
o.a.s.c.CoreContainer Initializing authentication plugin: solr.BasicAuthPlugin
[junit4] 2> 855517 INFO (zkCallback-2561-thread-1) [ ]
o.a.s.c.CoreContainer Initializing authentication plugin: solr.BasicAuthPlugin
[junit4] 2> 855517 INFO (qtp682035304-12875) [ ] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/authentication params={} status=0 QTime=0
[junit4] 2> 855517 INFO (zkCallback-2573-thread-2) [ ]
o.a.s.c.CoreContainer Security node changed, reloading security.json
[junit4] 2> 855517 INFO (zkCallback-2573-thread-2) [ ]
o.a.s.c.CoreContainer Initializing authentication plugin: solr.BasicAuthPlugin
[junit4] 2> 855518 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.s.BasicAuthIntegrationTest Added Basic Auth security Header
c29scjpTb2xyUm9ja3M=
[junit4] 2> 855521 INFO (qtp682035304-12877) [ ] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/authorization params={} status=0 QTime=2
[junit4] 2> 855523 INFO (zkCallback-2559-thread-2) [ ]
o.a.s.c.CoreContainer Security node changed, reloading security.json
[junit4] 2> 855523 INFO (zkCallback-2559-thread-2) [ ]
o.a.s.c.CoreContainer Initializing authorization plugin:
solr.RuleBasedAuthorizationPlugin
[junit4] 2> 855523 INFO (zkCallback-2559-thread-2) [ ]
o.a.s.c.CoreContainer Initializing authentication plugin: solr.BasicAuthPlugin
[junit4] 2> 855524 INFO (zkCallback-2561-thread-1) [ ]
o.a.s.c.CoreContainer Security node changed, reloading security.json
[junit4] 2> 855525 INFO (qtp61369407-12775) [ ] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/authorization params={} status=0 QTime=0
[junit4] 2> 855526 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.s.BasicAuthIntegrationTest Added Basic Auth security Header
aGFycnk6SGFycnlJc1ViZXJDb29s
[junit4] 2> 855527 INFO (qtp61369407-12775) [ ]
o.a.s.s.RuleBasedAuthorizationPlugin This resource is configured to have a
permission {
[junit4] 2> "name":"security-edit",
[junit4] 2> "role":"admin"}, The principal [principal: harry] does not
have the right role
[junit4] 2> 855527 INFO (qtp61369407-12775) [ ] o.a.s.s.HttpSolrCall
USER_REQUIRED auth header Basic aGFycnk6SGFycnlJc1ViZXJDb29s context :
userPrincipal: [[principal: harry]] type: [ADMIN], collections: [], Path:
[/admin/authorization] path : /admin/authorization params :
[junit4] 2> 855527 INFO (zkCallback-2561-thread-1) [ ]
o.a.s.c.CoreContainer Initializing authorization plugin:
solr.RuleBasedAuthorizationPlugin
[junit4] 2> 855528 INFO
(TEST-BasicAuthIntegrationTest.testBasicAuth-seed#[9A20E5C150D9C69F]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testBasicAuth
[junit4] 2> 855529 INFO (zkCallback-2561-thread-1) [ ]
o.a.s.c.CoreContainer Initializing authentication plugin: solr.BasicAuthPlugin
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=BasicAuthIntegrationTest -Dtests.method=testBasicAuth
-Dtests.seed=9A20E5C150D9C69F -Dtests.slow=true -Dtests.locale=ka
-Dtests.timezone=Europe/Luxembourg -Dtests.asserts=true
-Dtests.file.encoding=Cp1252
[junit4] FAILURE 1.78s J0 | BasicAuthIntegrationTest.testBasicAuth <<<
[junit4] > Throwable #1: java.lang.AssertionError: expected:<200> but
was:<403>
[junit4] > at
__randomizedtesting.SeedInfo.seed([9A20E5C150D9C69F:264E93D3F48A45E5]:0)
[junit4] > at
org.apache.solr.security.BasicAuthIntegrationTest.executeCommand(BasicAuthIntegrationTest.java:242)
[junit4] > at
org.apache.solr.security.BasicAuthIntegrationTest.testBasicAuth(BasicAuthIntegrationTest.java:154)
[junit4] > at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] > at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] > at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] > at
java.base/java.lang.reflect.Method.invoke(Method.java:564)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2> 855532 INFO (zkCallback-2573-thread-2) [ ]
o.a.s.c.CoreContainer Security node changed, reloading security.json
[junit4] 2> 855532 INFO (zkCallback-2573-thread-2) [ ]
o.a.s.c.CoreContainer Initializing authorization plugin:
solr.RuleBasedAuthorizationPlugin
[junit4] 2> 855532 INFO (zkCallback-2573-thread-2) [ ]
o.a.s.c.CoreContainer Initializing authentication plugin: solr.BasicAuthPlugin
[junit4] 2> 855533 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15e90d94c12000b, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2> 855537 INFO (jetty-closer-2545-thread-2) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@6d04f11a{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 855538 INFO (jetty-closer-2545-thread-2) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=443600582
[junit4] 2> 855539 INFO (jetty-closer-2545-thread-1) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@58148c57{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 855540 INFO (jetty-closer-2545-thread-1) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=2111842526
[junit4] 2> 855540 INFO (jetty-closer-2545-thread-3) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@29090af{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 855540 INFO (jetty-closer-2545-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 855541 INFO (jetty-closer-2545-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@458f958b: rootName =
solr_49364, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@17877ab
[junit4] 2> 855541 INFO (jetty-closer-2545-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 855541 INFO (jetty-closer-2545-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@5723fd27: rootName =
solr_49317, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@3c6acfac
[junit4] 2> 855541 INFO (jetty-closer-2545-thread-3) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=841466406
[junit4] 2> 855541 INFO (jetty-closer-2545-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 855541 INFO (jetty-closer-2545-thread-3) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@4320a60c: rootName =
solr_49323, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@18e487cc
[junit4] 2> 855553 INFO (jetty-closer-2545-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 855553 INFO (jetty-closer-2545-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@4397f68d: rootName =
solr_49364, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@b8aa026
[junit4] 2> 855553 INFO (jetty-closer-2545-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 855553 INFO (jetty-closer-2545-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1649f602: rootName =
solr_49317, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@b8aa026
[junit4] 2> 855553 INFO (jetty-closer-2545-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 855553 INFO (jetty-closer-2545-thread-3) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@403f4ff8: rootName =
solr_49323, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@b8aa026
[junit4] 2> 855560 INFO (jetty-closer-2545-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 855561 INFO (jetty-closer-2545-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 855560 INFO (jetty-closer-2545-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 855561 INFO (jetty-closer-2545-thread-3) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@5243a40a: rootName =
solr_49323, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@16a3710a
[junit4] 2> 855561 INFO (jetty-closer-2545-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@30ee7174: rootName =
solr_49317, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@16a3710a
[junit4] 2> 855561 INFO (jetty-closer-2545-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@36138c2f: rootName =
solr_49364, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@16a3710a
[junit4] 2> 855562 INFO (jetty-closer-2545-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 855562 INFO (jetty-closer-2545-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 855562 INFO (jetty-closer-2545-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 855563 INFO (coreCloseExecutor-4557-thread-1) [ ]
o.a.s.c.SolrCore [authCollection_shard2_replica_n1] CLOSING SolrCore
org.apache.solr.core.SolrCore@294e8902
[junit4] 2> 855563 INFO (coreCloseExecutor-4557-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.authCollection.shard2.replica_n1, tag=693012738
[junit4] 2> 855563 INFO (coreCloseExecutor-4557-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@5b387ab2: rootName =
solr_49323, domain = solr.core.authCollection.shard2.replica_n1, service url =
null, agent id = null] for registry solr.core.authCollection.shard2.replica_n1
/ com.codahale.metrics.MetricRegistry@639f8900
[junit4] 2> 855566 INFO (coreCloseExecutor-4558-thread-1) [ ]
o.a.s.c.SolrCore [authCollection_shard1_replica_n1] CLOSING SolrCore
org.apache.solr.core.SolrCore@166df9e3
[junit4] 2> 855567 INFO (coreCloseExecutor-4558-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.authCollection.shard1.replica_n1, tag=376306147
[junit4] 2> 855567 INFO (coreCloseExecutor-4558-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@4a3589f0: rootName =
solr_49317, domain = solr.core.authCollection.shard1.replica_n1, service url =
null, agent id = null] for registry solr.core.authCollection.shard1.replica_n1
/ com.codahale.metrics.MetricRegistry@3a2bb9f2
[junit4] 2> 855567 INFO (coreCloseExecutor-4559-thread-1) [ ]
o.a.s.c.SolrCore [authCollection_shard3_replica_n1] CLOSING SolrCore
org.apache.solr.core.SolrCore@22291287
[junit4] 2> 855567 INFO (coreCloseExecutor-4559-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.authCollection.shard3.replica_n1, tag=573117063
[junit4] 2> 855568 INFO (coreCloseExecutor-4559-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@608ba448: rootName =
solr_49364, domain = solr.core.authCollection.shard3.replica_n1, service url =
null, agent id = null] for registry solr.core.authCollection.shard3.replica_n1
/ com.codahale.metrics.MetricRegistry@65c699d3
[junit4] 2> 855570 INFO (coreCloseExecutor-4557-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.collection.authCollection.shard2.leader, tag=693012738
[junit4] 2> 855574 INFO (coreCloseExecutor-4559-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.collection.authCollection.shard3.leader, tag=573117063
[junit4] 2> 855575 INFO (jetty-closer-2545-thread-3) [ ]
o.a.s.c.Overseer Overseer
(id=98675504807280649-127.0.0.1:49323_solr-n_0000000001) closing
[junit4] 2> 855575 INFO
(OverseerStateUpdate-98675504807280649-127.0.0.1:49323_solr-n_0000000001) [
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:49323_solr
[junit4] 2> 855576 INFO (coreCloseExecutor-4558-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.collection.authCollection.shard1.leader, tag=376306147
[junit4] 2> 855576 WARN (zkCallback-2561-thread-1) [ ]
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK:
[KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 855579 INFO (jetty-closer-2545-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@4dc2d853{/solr,null,UNAVAILABLE}
[junit4] 2> 855579 INFO (zkCallback-2559-thread-2) [ ]
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:49317_solr
[junit4] 2> 855580 INFO (zkCallback-2559-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 855580 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15e90d94c12000e, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2> 855580 INFO (zkCallback-2573-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 855580 WARN (zkCallback-2573-thread-1) [ ]
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK:
[KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 855581 INFO (zkCallback-2559-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 855581 INFO (jetty-closer-2545-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@73bf5a3c{/solr,null,UNAVAILABLE}
[junit4] 2> 855582 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15e90d94c120008, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2> 855582 WARN (zkCallback-2559-thread-2) [ ]
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK:
[KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 855583 INFO (jetty-closer-2545-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@3a1980dd{/solr,null,UNAVAILABLE}
[junit4] 2> 855584 ERROR
(SUITE-BasicAuthIntegrationTest-seed#[9A20E5C150D9C69F]-worker) [ ]
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper
server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 855584 INFO
(SUITE-BasicAuthIntegrationTest-seed#[9A20E5C150D9C69F]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:49313 49313
[junit4] 2> 855585 INFO (Thread-2320) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:49313 49313
[junit4] 2> 855586 WARN (Thread-2320) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 5 /solr/aliases.json
[junit4] 2> 5 /solr/clusterprops.json
[junit4] 2> 4 /solr/security.json
[junit4] 2> 4 /solr/configs/conf
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 25 /solr/collections/authCollection/state.json
[junit4] 2> 5 /solr/clusterstate.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 5 /solr/collections
[junit4] 2> 4 /solr/live_nodes
[junit4] 2> 2 /solr/overseer/queue
[junit4] 2> 2 /solr/overseer/collection-queue-work
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at:
C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.security.BasicAuthIntegrationTest_9A20E5C150D9C69F-001
[junit4] 2> Sep 17, 2017 5:18:38 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 5 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {},
docValues:{}, maxPointsInLeafNode=1230, maxMBSortInHeap=7.302366381339711,
sim=RandomSimilarity(queryNorm=false): {}, locale=ka, timezone=Europe/Luxembourg
[junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 9
(64-bit)/cpus=3,threads=1,free=160073600,total=536870912
[junit4] 2> NOTE: All tests run in this JVM:
[TestTrackingShardHandlerFactory, TestSolrConfigHandlerCloud,
TestPseudoReturnFields, ClassificationUpdateProcessorFactoryTest,
HdfsTlogReplayBufferedWhileIndexingTest, ZkCLITest, SolrMetricManagerTest,
TestShardHandlerFactory, TestSchemalessBufferedUpdates,
DistributedVersionInfoTest, NumericFieldsTest,
SpellCheckCollatorWithCollapseTest, TestRecoveryHdfs,
PeerSyncWithIndexFingerprintCachingTest, WordBreakSolrSpellCheckerTest,
HighlighterTest, TestCloudManagedSchema, TestPKIAuthenticationPlugin,
ClusterStateUpdateTest, TestAtomicUpdateErrorCases,
TestJavabinTupleStreamParser, TestMaxTokenLenTokenizer,
TestSolrDeletionPolicy2, TestHttpShardHandlerFactory, BadCopyFieldTest,
CollectionReloadTest, TestQuerySenderListener, SubstringBytesRefFilterTest,
TestCloudJSONFacetJoinDomain, TestSolrQueryResponse, CleanupOldIndexTest,
TestDocBasedVersionConstraints, RuleEngineTest, HighlighterMaxOffsetTest,
QueryParsingTest, TestSurroundQueryParser, TestConfigSetsAPIZkFailure,
TestBinaryField, FastVectorHighlighterTest, TestCorePropertiesReload,
TestFieldCacheSort, TestCustomSort, ChaosMonkeySafeLeaderWithPullReplicasTest,
TestStressLiveNodes, TestMiniSolrCloudClusterSSL, TestNRTOpen,
OutputWriterTest, IndexSchemaTest, SolrGraphiteReporterTest,
PreAnalyzedFieldManagedSchemaCloudTest, TestRTimerTree,
TestNumericRangeQuery64, TlogReplayBufferedWhileIndexingTest,
UnloadDistributedZkTest, TestSchemaVersionResource,
TestFuzzyAnalyzedSuggestions, ResponseHeaderTest, AlternateDirectoryTest,
TestLegacyField, SolrCloudReportersTest, TestRandomRequestDistribution,
TestCSVResponseWriter, TestCursorMarkWithoutUniqueKey, TestConfigOverlay,
SuggesterTest, TestSwe
[...truncated too long message...]
ContextHandler Started
o.e.j.s.ServletContextHandler@7f716ec4{/solr,null,AVAILABLE}
[junit4] 2> 65709 INFO
(TEST-TestLBHttpSolrClient.testTwoServers-seed#[EBC40A5260ADFE9D]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@3a45ecf6{HTTP/1.1,[http/1.1]}{127.0.0.1:?????}
[junit4] 2> 65710 INFO
(TEST-TestLBHttpSolrClient.testTwoServers-seed#[EBC40A5260ADFE9D]) [ ]
o.e.j.s.Server Started @?????ms
[junit4] 2> 65710 INFO
(TEST-TestLBHttpSolrClient.testTwoServers-seed#[EBC40A5260ADFE9D]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
solrconfig=bad_solrconfig.xml,
solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.TestLBHttpSolrClient_EBC40A5260ADFE9D-001\instance-0-001\collection1\data,
hostPort=64803}
[junit4] 2> 65710 ERROR
(TEST-TestLBHttpSolrClient.testTwoServers-seed#[EBC40A5260ADFE9D]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 65710 INFO
(TEST-TestLBHttpSolrClient.testTwoServers-seed#[EBC40A5260ADFE9D]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.0.0
[junit4] 2> 65711 INFO
(TEST-TestLBHttpSolrClient.testTwoServers-seed#[EBC40A5260ADFE9D]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on
port null
[junit4] 2> 65711 INFO
(TEST-TestLBHttpSolrClient.testTwoServers-seed#[EBC40A5260ADFE9D]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 65711 INFO
(TEST-TestLBHttpSolrClient.testTwoServers-seed#[EBC40A5260ADFE9D]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-09-17T17:49:29.653370900Z
[junit4] 2> 65711 INFO
(TEST-TestLBHttpSolrClient.testTwoServers-seed#[EBC40A5260ADFE9D]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.TestLBHttpSolrClient_EBC40A5260ADFE9D-001\instance-0-001\solr.xml
[junit4] 2> 65762 INFO
(TEST-TestLBHttpSolrClient.testTwoServers-seed#[EBC40A5260ADFE9D]) [ ]
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.TestLBHttpSolrClient_EBC40A5260ADFE9D-001\instance-0-001\.
[junit4] 2> 65762 INFO
(TEST-TestLBHttpSolrClient.testTwoServers-seed#[EBC40A5260ADFE9D]) [ ]
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 65782 INFO (coreLoadExecutor-193-thread-1) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 65789 INFO (coreLoadExecutor-193-thread-1) [ ]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 65791 INFO (coreLoadExecutor-193-thread-1) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 65791 INFO (coreLoadExecutor-193-thread-1) [ ]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
instancedir
C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.TestLBHttpSolrClient_EBC40A5260ADFE9D-001\instance-0-001\.\collection1,
trusted=true
[junit4] 2> 65791 INFO (coreLoadExecutor-193-thread-1) [ ]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 65791 INFO (coreLoadExecutor-193-thread-1) [ ]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.TestLBHttpSolrClient_EBC40A5260ADFE9D-001\instance-0-001\collection1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.TestLBHttpSolrClient_EBC40A5260ADFE9D-001\instance-0-001\.\collection1\data\]
[junit4] 2> 65845 INFO (coreLoadExecutor-193-thread-1) [ ]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 65845 INFO (coreLoadExecutor-193-thread-1) [ ]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 65852 INFO (coreLoadExecutor-193-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@13ef9752[collection1] main]
[junit4] 2> 65853 INFO (coreLoadExecutor-193-thread-1) [ ]
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir:
C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.TestLBHttpSolrClient_EBC40A5260ADFE9D-001\instance-0-001\collection1\conf
[junit4] 2> 65853 INFO (coreLoadExecutor-193-thread-1) [ ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 65854 INFO (searcherExecutor-194-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@13ef9752[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c10)))}
[junit4] 2> 66191 INFO (qtp748114412-414) [ ] o.a.s.c.S.Request
[collection1] webapp=/solr path=/select
params={q=*:*&distrib=false&sort=_docid_+asc&rows=0&wt=javabin&version=2}
hits=10 status=0 QTime=0
[junit4] 2> 67471 INFO (qtp748114412-415) [ ] o.a.s.c.S.Request
[collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2}
hits=10 status=0 QTime=0
[junit4] 2> 67472 INFO
(TEST-TestLBHttpSolrClient.testTwoServers-seed#[EBC40A5260ADFE9D]) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@3a45ecf6{HTTP/1.1,[http/1.1]}{127.0.0.1:?????}
[junit4] 2> 67472 INFO
(TEST-TestLBHttpSolrClient.testTwoServers-seed#[EBC40A5260ADFE9D]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1146156285
[junit4] 2> 67473 INFO
(TEST-TestLBHttpSolrClient.testTwoServers-seed#[EBC40A5260ADFE9D]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 67473 INFO
(TEST-TestLBHttpSolrClient.testTwoServers-seed#[EBC40A5260ADFE9D]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 67473 INFO
(TEST-TestLBHttpSolrClient.testTwoServers-seed#[EBC40A5260ADFE9D]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 67473 INFO
(TEST-TestLBHttpSolrClient.testTwoServers-seed#[EBC40A5260ADFE9D]) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 67473 INFO (coreCloseExecutor-198-thread-1) [ ]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@7178ab9d
[junit4] 2> 67473 INFO (coreCloseExecutor-198-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=1903733661
[junit4] 2> 67485 INFO
(TEST-TestLBHttpSolrClient.testTwoServers-seed#[EBC40A5260ADFE9D]) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@7f716ec4{/solr,null,UNAVAILABLE}
[junit4] 2> 67492 INFO
(TEST-TestLBHttpSolrClient.testTwoServers-seed#[EBC40A5260ADFE9D]) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@77c45053{HTTP/1.1,[http/1.1]}{127.0.0.1:?}
[junit4] 2> 67492 INFO
(TEST-TestLBHttpSolrClient.testTwoServers-seed#[EBC40A5260ADFE9D]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=999719154
[junit4] 2> 67492 INFO
(TEST-TestLBHttpSolrClient.testTwoServers-seed#[EBC40A5260ADFE9D]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 67492 INFO
(TEST-TestLBHttpSolrClient.testTwoServers-seed#[EBC40A5260ADFE9D]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 67492 INFO
(TEST-TestLBHttpSolrClient.testTwoServers-seed#[EBC40A5260ADFE9D]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 67493 INFO
(TEST-TestLBHttpSolrClient.testTwoServers-seed#[EBC40A5260ADFE9D]) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 67493 INFO (coreCloseExecutor-200-thread-1) [ ]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@6e298730
[junit4] 2> 67493 INFO (coreCloseExecutor-200-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=1848215344
[junit4] 2> 67499 INFO
(TEST-TestLBHttpSolrClient.testTwoServers-seed#[EBC40A5260ADFE9D]) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@3ba81604{/solr,null,UNAVAILABLE}
[junit4] 2> 67503 INFO
(TEST-TestLBHttpSolrClient.testTwoServers-seed#[EBC40A5260ADFE9D]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testTwoServers
[junit4] 2> NOTE: leaving temporary files on disk at:
C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.TestLBHttpSolrClient_EBC40A5260ADFE9D-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70):
{name=PostingsFormat(name=Direct), id=PostingsFormat(name=Direct)},
docValues:{}, maxPointsInLeafNode=306, maxMBSortInHeap=5.151648609866152,
sim=RandomSimilarity(queryNorm=false): {}, locale=ar-QA,
timezone=Australia/Melbourne
[junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 9
(64-bit)/cpus=3,threads=2,free=45858472,total=100663296
[junit4] 2> NOTE: All tests run in this JVM: [ClientUtilsTest,
SquareRootEvaluatorTest, TestV1toV2ApiMapper, CompoundEvaluatorTest,
SolrExampleBinaryTest, TestCollectionAdminRequest,
HttpSolrClientSSLAuthConPoolTest, SolrParamTest, GetByIdTest, SolrQueryTest,
NotEvaluatorTest, TangentEvaluatorTest, DocumentAnalysisResponseTest,
TestLBHttpSolrClient]
[junit4] Completed [30/135 (1!)] on J1 in 50.75s, 3 tests, 1 failure <<<
FAILURES!
[...truncated 36011 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
